builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1468355520.78 results: success (0) buildid: 20160712125228 builduid: 3db5ee6d36e948219af4b41b58baf491 revision: 1b779cb4e88190a365dab80a67299bbbdf883680 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:00.783892) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:00.784434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:00.784734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:00.841943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:00.842258) ========= 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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 13:32:01-- 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% 69.5M=0s 2016-07-12 13:32:01 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202378 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.059404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.059680) ========= 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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.109791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.110107) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b779cb4e88190a365dab80a67299bbbdf883680 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b779cb4e88190a365dab80a67299bbbdf883680 --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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 13:32:01,480 truncating revision to first 12 chars 2016-07-12 13:32:01,480 Setting DEBUG logging. 2016-07-12 13:32:01,480 attempt 1/10 2016-07-12 13:32:01,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b779cb4e881?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 13:32:01,809 unpacking tar archive at: fx-team-1b779cb4e881/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651423 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.775060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.775396) ========= script_repo_revision: 1b779cb4e88190a365dab80a67299bbbdf883680 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.775783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.776059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:32:01.785947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-12 13:32:01.786257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:02 INFO - MultiFileLogger online at 20160712 13:32:02 in /builds/slave/test 13:32:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:32:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:02 INFO - {'append_to_log': False, 13:32:02 INFO - 'base_work_dir': '/builds/slave/test', 13:32:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:32:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:02 INFO - 'branch': 'Fx-Team-Non-PGO', 13:32:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:02 INFO - 'config_files': ('talos/linux_config.py',), 13:32:02 INFO - 'default_actions': ('clobber', 13:32:02 INFO - 'read-buildbot-config', 13:32:02 INFO - 'download-and-extract', 13:32:02 INFO - 'populate-webroot', 13:32:02 INFO - 'create-virtualenv', 13:32:02 INFO - 'install', 13:32:02 INFO - 'run-tests'), 13:32:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:02 INFO - 'download_minidump_stackwalk': True, 13:32:02 INFO - 'download_symbols': 'ondemand', 13:32:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:02 INFO - 'installer_path': 'installer.exe', 13:32:02 INFO - 'log_level': 'info', 13:32:02 INFO - 'log_name': 'talos', 13:32:02 INFO - 'log_to_console': True, 13:32:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:02 INFO - 'opt_config_files': (), 13:32:02 INFO - 'pip_index': False, 13:32:02 INFO - 'sps_profile': False, 13:32:02 INFO - 'sps_profile_interval': 0, 13:32:02 INFO - 'suite': 'dromaeojs', 13:32:02 INFO - 'system_bits': '32', 13:32:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:02 INFO - 'title': 'talos-linux64-ix-025', 13:32:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:02 INFO - 'use_talos_json': True, 13:32:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:02 INFO - 'work_dir': 'build'} 13:32:02 INFO - ##### 13:32:02 INFO - ##### Running clobber step. 13:32:02 INFO - ##### 13:32:02 INFO - Running pre-action listener: _resource_record_pre_action 13:32:02 INFO - Running main action method: clobber 13:32:02 INFO - rmtree: /builds/slave/test/build 13:32:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:02 INFO - Running post-action listener: _resource_record_post_action 13:32:02 INFO - ##### 13:32:02 INFO - ##### Finished clobber step (success) 13:32:02 INFO - ##### 13:32:02 INFO - ##### 13:32:02 INFO - ##### Running read-buildbot-config step. 13:32:02 INFO - ##### 13:32:02 INFO - Running pre-action listener: _resource_record_pre_action 13:32:02 INFO - Running main action method: read_buildbot_config 13:32:02 INFO - Using buildbot properties: 13:32:02 INFO - { 13:32:02 INFO - "project": "", 13:32:02 INFO - "product": "firefox", 13:32:02 INFO - "script_repo_revision": "production", 13:32:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:32:02 INFO - "repository": "", 13:32:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:32:02 INFO - "buildid": "20160712125228", 13:32:02 INFO - "pgo_build": "False", 13:32:02 INFO - "basedir": "/builds/slave/test", 13:32:02 INFO - "buildnumber": 3145, 13:32:02 INFO - "slavename": "talos-linux64-ix-025", 13:32:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:32:02 INFO - "platform": "ubuntu64_hw", 13:32:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:32:02 INFO - "branch": "fx-team", 13:32:02 INFO - "repo_path": "integration/fx-team", 13:32:02 INFO - "revision": "1b779cb4e88190a365dab80a67299bbbdf883680", 13:32:02 INFO - "stage_platform": "linux64", 13:32:02 INFO - "builduid": "3db5ee6d36e948219af4b41b58baf491", 13:32:02 INFO - "slavebuilddir": "test" 13:32:02 INFO - } 13:32:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:32:02 INFO - Running post-action listener: _resource_record_post_action 13:32:02 INFO - ##### 13:32:02 INFO - ##### Finished read-buildbot-config step (success) 13:32:02 INFO - ##### 13:32:02 INFO - ##### 13:32:02 INFO - ##### Running download-and-extract step. 13:32:02 INFO - ##### 13:32:02 INFO - Running pre-action listener: _resource_record_pre_action 13:32:02 INFO - Running main action method: download_and_extract 13:32:02 INFO - mkdir: /builds/slave/test/build/tests 13:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:02 INFO - https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:32:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:03 INFO - Downloaded 1361 bytes. 13:32:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:03 INFO - Using the following test package requirements: 13:32:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:32:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'jsshell-linux-x86_64.zip'], 13:32:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:03 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')]} 13:32:03 INFO - https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:07 INFO - Downloaded 22750521 bytes. 13:32:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:32:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:32:08 INFO - Return code: 0 13:32:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:08 INFO - https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:14 INFO - Downloaded 22750521 bytes. 13:32:14 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'] 13:32:14 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 13:32:15 INFO - Return code: 0 13:32:15 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')]} 13:32:15 INFO - https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:17 INFO - Downloaded 14403317 bytes. 13:32:17 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'] 13:32:17 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 13:32:17 INFO - Return code: 0 13:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:17 INFO - https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HO5CFHiyR7e_z2rHda0vfw/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 13:32:19 INFO - Downloaded 56664181 bytes. 13:32:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:19 INFO - mkdir: /builds/slave/test/properties 13:32:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:19 INFO - Contents: 13:32:19 INFO - build_url:https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:20 INFO - Running post-action listener: _resource_record_post_action 13:32:20 INFO - Running post-action listener: set_extra_try_arguments 13:32:20 INFO - ##### 13:32:20 INFO - ##### Finished download-and-extract step (success) 13:32:20 INFO - ##### 13:32:20 INFO - ##### 13:32:20 INFO - ##### Running populate-webroot step. 13:32:20 INFO - ##### 13:32:20 INFO - Running pre-action listener: _resource_record_pre_action 13:32:20 INFO - Running main action method: populate_webroot 13:32:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:20 INFO - '--tppagecycles', 13:32:20 INFO - '7'], 13:32:20 INFO - 'tests': ['tsvgm']}}, 13:32:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:32:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:32:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:32:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['damp', 'tps']}, 13:32:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'tests': ['damp', 'tps']}, 13:32:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['dromaeo_dom']}, 13:32:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['basic_compositor_video']}, 13:32:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:32:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'other-e10s': {'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['a11yr', 13:32:20 INFO - 'ts_paint', 13:32:20 INFO - 'tpaint', 13:32:20 INFO - 'sessionrestore', 13:32:20 INFO - 'sessionrestore_no_auto_restore', 13:32:20 INFO - 'tabpaint']}, 13:32:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['tsvgx', 13:32:20 INFO - 'tsvgr_opacity', 13:32:20 INFO - 'tart', 13:32:20 INFO - 'tscrollx', 13:32:20 INFO - 'cart']}, 13:32:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:32:20 INFO - 'tsvgr_opacity', 13:32:20 INFO - 'tart', 13:32:20 INFO - 'tscrollx', 13:32:20 INFO - 'cart']}, 13:32:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'talos_options': ['--disable-e10s'], 13:32:20 INFO - 'tests': ['tp5o']}, 13:32:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'tests': ['tp5o']}, 13:32:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'talos_options': ['--disable-e10s', 13:32:20 INFO - '--xperf_path', 13:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:20 INFO - 'tests': ['tp5n']}, 13:32:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:20 INFO - 'talos_options': ['--xperf_path', 13:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:20 INFO - 'tests': ['tp5n']}}, 13:32:20 INFO - 'talos.zip': {'path': '', 13:32:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:20 INFO - Running post-action listener: _resource_record_post_action 13:32:20 INFO - ##### 13:32:20 INFO - ##### Finished populate-webroot step (success) 13:32:20 INFO - ##### 13:32:20 INFO - ##### 13:32:20 INFO - ##### Running create-virtualenv step. 13:32:20 INFO - ##### 13:32:20 INFO - Running pre-action listener: _resource_record_pre_action 13:32:20 INFO - Running main action method: create_virtualenv 13:32:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:20 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 13:32:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:20 INFO - Using real prefix '/usr' 13:32:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:22 INFO - Installing pip.................done. 13:32:22 INFO - Return code: 0 13:32:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:32:22 INFO - Using env: {'DISPLAY': ':0', 13:32:22 INFO - 'HOME': '/home/cltbld', 13:32:22 INFO - 'LANG': 'en_US.UTF-8', 13:32:22 INFO - 'LANGUAGE': 'en_US:en', 13:32:22 INFO - 'LOGNAME': 'cltbld', 13:32:22 INFO - 'MAIL': '/var/mail/cltbld', 13:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:22 INFO - 'MOZ_NO_REMOTE': '1', 13:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:22 INFO - 'NO_EM_RESTART': '1', 13:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:22 INFO - 'PWD': '/builds/slave/test', 13:32:22 INFO - 'SHELL': '/bin/bash', 13:32:22 INFO - 'SHLVL': '1', 13:32:22 INFO - 'TERM': 'linux', 13:32:22 INFO - 'TMOUT': '86400', 13:32:22 INFO - 'USER': 'cltbld', 13:32:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:22 INFO - '_': '/tools/buildbot/bin/python'} 13:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:22 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 13:32:22 INFO - Cleaning up... 13:32:22 INFO - Return code: 0 13:32:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:32:22 INFO - Using env: {'DISPLAY': ':0', 13:32:22 INFO - 'HOME': '/home/cltbld', 13:32:22 INFO - 'LANG': 'en_US.UTF-8', 13:32:22 INFO - 'LANGUAGE': 'en_US:en', 13:32:22 INFO - 'LOGNAME': 'cltbld', 13:32:22 INFO - 'MAIL': '/var/mail/cltbld', 13:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:22 INFO - 'MOZ_NO_REMOTE': '1', 13:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:22 INFO - 'NO_EM_RESTART': '1', 13:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:22 INFO - 'PWD': '/builds/slave/test', 13:32:22 INFO - 'SHELL': '/bin/bash', 13:32:22 INFO - 'SHLVL': '1', 13:32:22 INFO - 'TERM': 'linux', 13:32:23 INFO - 'TMOUT': '86400', 13:32:23 INFO - 'USER': 'cltbld', 13:32:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:23 INFO - '_': '/tools/buildbot/bin/python'} 13:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:23 INFO - Downloading/unpacking psutil>=3.1.1 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:25 INFO - Installing collected packages: psutil 13:32:25 INFO - Running setup.py install for psutil 13:32:25 INFO - building 'psutil._psutil_linux' extension 13:32:25 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 13:32:25 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 13:32:25 INFO - building 'psutil._psutil_posix' extension 13:32:25 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 13:32:25 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 13:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:25 INFO - Successfully installed psutil 13:32:25 INFO - Cleaning up... 13:32:25 INFO - Return code: 0 13:32:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:32: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 mozsystemmonitor==0.3 13:32:25 INFO - Using env: {'DISPLAY': ':0', 13:32:25 INFO - 'HOME': '/home/cltbld', 13:32:25 INFO - 'LANG': 'en_US.UTF-8', 13:32:25 INFO - 'LANGUAGE': 'en_US:en', 13:32:25 INFO - 'LOGNAME': 'cltbld', 13:32:25 INFO - 'MAIL': '/var/mail/cltbld', 13:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:25 INFO - 'MOZ_NO_REMOTE': '1', 13:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:25 INFO - 'NO_EM_RESTART': '1', 13:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:25 INFO - 'PWD': '/builds/slave/test', 13:32:25 INFO - 'SHELL': '/bin/bash', 13:32:25 INFO - 'SHLVL': '1', 13:32:25 INFO - 'TERM': 'linux', 13:32:25 INFO - 'TMOUT': '86400', 13:32:25 INFO - 'USER': 'cltbld', 13:32:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:25 INFO - '_': '/tools/buildbot/bin/python'} 13:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 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 13:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:27 INFO - Installing collected packages: mozsystemmonitor 13:32:27 INFO - Running setup.py install for mozsystemmonitor 13:32:28 INFO - Successfully installed mozsystemmonitor 13:32:28 INFO - Cleaning up... 13:32:28 INFO - Return code: 0 13:32:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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', '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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:32: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 jsonschema==2.5.1 13:32:28 INFO - Using env: {'DISPLAY': ':0', 13:32:28 INFO - 'HOME': '/home/cltbld', 13:32:28 INFO - 'LANG': 'en_US.UTF-8', 13:32:28 INFO - 'LANGUAGE': 'en_US:en', 13:32:28 INFO - 'LOGNAME': 'cltbld', 13:32:28 INFO - 'MAIL': '/var/mail/cltbld', 13:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:28 INFO - 'MOZ_NO_REMOTE': '1', 13:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:28 INFO - 'NO_EM_RESTART': '1', 13:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:28 INFO - 'PWD': '/builds/slave/test', 13:32:28 INFO - 'SHELL': '/bin/bash', 13:32:28 INFO - 'SHLVL': '1', 13:32:28 INFO - 'TERM': 'linux', 13:32:28 INFO - 'TMOUT': '86400', 13:32:28 INFO - 'USER': 'cltbld', 13:32:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:28 INFO - '_': '/tools/buildbot/bin/python'} 13:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:30 INFO - warning: no files found matching '*.txt' 13:32:30 INFO - no previously-included directories found matching 'build' 13:32:30 INFO - no previously-included directories found matching 'dist' 13:32:30 INFO - no previously-included directories found matching '.git*' 13:32:30 INFO - Installing collected packages: jsonschema, functools32 13:32:30 INFO - Running setup.py install for functools32 13:32:30 INFO - warning: no files found matching '*.txt' 13:32:30 INFO - no previously-included directories found matching 'build' 13:32:30 INFO - no previously-included directories found matching 'dist' 13:32:30 INFO - no previously-included directories found matching '.git*' 13:32:30 INFO - Successfully installed jsonschema functools32 13:32:30 INFO - Cleaning up... 13:32:30 INFO - Return code: 0 13:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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', '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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:32: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 blobuploader==1.2.4 13:32:30 INFO - Using env: {'DISPLAY': ':0', 13:32:30 INFO - 'HOME': '/home/cltbld', 13:32:30 INFO - 'LANG': 'en_US.UTF-8', 13:32:30 INFO - 'LANGUAGE': 'en_US:en', 13:32:30 INFO - 'LOGNAME': 'cltbld', 13:32:30 INFO - 'MAIL': '/var/mail/cltbld', 13:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:30 INFO - 'MOZ_NO_REMOTE': '1', 13:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:30 INFO - 'NO_EM_RESTART': '1', 13:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:30 INFO - 'PWD': '/builds/slave/test', 13:32:30 INFO - 'SHELL': '/bin/bash', 13:32:30 INFO - 'SHLVL': '1', 13:32:30 INFO - 'TERM': 'linux', 13:32:30 INFO - 'TMOUT': '86400', 13:32:30 INFO - 'USER': 'cltbld', 13:32:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:30 INFO - '_': '/tools/buildbot/bin/python'} 13:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:33 INFO - Downloading docopt-0.6.1.tar.gz 13:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:33 INFO - Running setup.py install for blobuploader 13:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:33 INFO - Running setup.py install for requests 13:32:34 INFO - Running setup.py install for docopt 13:32:34 INFO - Successfully installed blobuploader requests docopt 13:32:34 INFO - Cleaning up... 13:32:34 INFO - Return code: 0 13:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:34 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:34 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 13:32:34 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 13:32:34 INFO - Using env: {'DISPLAY': ':0', 13:32:34 INFO - 'HOME': '/home/cltbld', 13:32:34 INFO - 'LANG': 'en_US.UTF-8', 13:32:34 INFO - 'LANGUAGE': 'en_US:en', 13:32:34 INFO - 'LOGNAME': 'cltbld', 13:32:34 INFO - 'MAIL': '/var/mail/cltbld', 13:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:34 INFO - 'MOZ_NO_REMOTE': '1', 13:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:34 INFO - 'NO_EM_RESTART': '1', 13:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:34 INFO - 'PWD': '/builds/slave/test', 13:32:34 INFO - 'SHELL': '/bin/bash', 13:32:34 INFO - 'SHLVL': '1', 13:32:34 INFO - 'TERM': 'linux', 13:32:34 INFO - 'TMOUT': '86400', 13:32:34 INFO - 'USER': 'cltbld', 13:32:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:34 INFO - '_': '/tools/buildbot/bin/python'} 13:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:34 INFO - Running setup.py (path:/tmp/pip-zn1QrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:34 INFO - Running setup.py (path:/tmp/pip-sGy2Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:34 INFO - Running setup.py (path:/tmp/pip-eaYFd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:34 INFO - Running setup.py (path:/tmp/pip-b2m8Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:34 INFO - Running setup.py (path:/tmp/pip-_MjLBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:34 INFO - Running setup.py (path:/tmp/pip-NLfkNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:34 INFO - Running setup.py (path:/tmp/pip-Iz1BjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:34 INFO - Running setup.py (path:/tmp/pip-Fone70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:35 INFO - Running setup.py (path:/tmp/pip-zLGhnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:35 INFO - Running setup.py (path:/tmp/pip-Ix4bzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:35 INFO - Running setup.py (path:/tmp/pip-499LnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:35 INFO - Running setup.py (path:/tmp/pip-tqUfxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:35 INFO - Running setup.py (path:/tmp/pip-6keHgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:35 INFO - Running setup.py (path:/tmp/pip-uF1mK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:35 INFO - Running setup.py (path:/tmp/pip-lwF2xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:35 INFO - Running setup.py (path:/tmp/pip-qK8VQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:35 INFO - Running setup.py (path:/tmp/pip-TYRaJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:35 INFO - Running setup.py install for manifestparser 13:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:35 INFO - Running setup.py install for mozcrash 13:32:35 INFO - Running setup.py install for mozdebug 13:32:35 INFO - Running setup.py install for mozdevice 13:32:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozfile 13:32:36 INFO - Running setup.py install for mozhttpd 13:32:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozinfo 13:32:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozInstall 13:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozleak 13:32:36 INFO - Running setup.py install for mozlog 13:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for moznetwork 13:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozprocess 13:32:36 INFO - Running setup.py install for mozprofile 13:32:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Running setup.py install for mozrunner 13:32:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Running setup.py install for mozscreenshot 13:32:37 INFO - Running setup.py install for moztest 13:32:37 INFO - Running setup.py install for mozversion 13:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:37 INFO - Cleaning up... 13:32:37 INFO - Return code: 0 13:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:37 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:37 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 13:32:37 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 13:32:37 INFO - Using env: {'DISPLAY': ':0', 13:32:37 INFO - 'HOME': '/home/cltbld', 13:32:37 INFO - 'LANG': 'en_US.UTF-8', 13:32:37 INFO - 'LANGUAGE': 'en_US:en', 13:32:37 INFO - 'LOGNAME': 'cltbld', 13:32:37 INFO - 'MAIL': '/var/mail/cltbld', 13:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:37 INFO - 'MOZ_NO_REMOTE': '1', 13:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:37 INFO - 'NO_EM_RESTART': '1', 13:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:37 INFO - 'PWD': '/builds/slave/test', 13:32:37 INFO - 'SHELL': '/bin/bash', 13:32:37 INFO - 'SHLVL': '1', 13:32:37 INFO - 'TERM': 'linux', 13:32:37 INFO - 'TMOUT': '86400', 13:32:37 INFO - 'USER': 'cltbld', 13:32:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:37 INFO - '_': '/tools/buildbot/bin/python'} 13:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:37 INFO - Running setup.py (path:/tmp/pip-hE1KMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:37 INFO - Running setup.py (path:/tmp/pip-nmnI5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:37 INFO - Running setup.py (path:/tmp/pip-7jabBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:37 INFO - Running setup.py (path:/tmp/pip-6vNzew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:37 INFO - Running setup.py (path:/tmp/pip-bJe0Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:38 INFO - Running setup.py (path:/tmp/pip-zhLEEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:38 INFO - Running setup.py (path:/tmp/pip-kxycYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:38 INFO - Running setup.py (path:/tmp/pip-MIpXoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:38 INFO - Running setup.py (path:/tmp/pip-5FOcAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:38 INFO - Running setup.py (path:/tmp/pip-i5NpKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:38 INFO - Running setup.py (path:/tmp/pip-T9oo5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:38 INFO - Running setup.py (path:/tmp/pip-JTszsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:38 INFO - Running setup.py (path:/tmp/pip-Ur_rtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:38 INFO - Running setup.py (path:/tmp/pip-Zga4BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:38 INFO - Running setup.py (path:/tmp/pip-eXcrRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:38 INFO - Running setup.py (path:/tmp/pip-XG8GXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:38 INFO - Running setup.py (path:/tmp/pip-aDEWgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:38 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 13:32:38 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 13:32:38 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 13:32:38 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 13:32:38 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 13:32:38 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 13:32:40 INFO - Downloading blessings-1.6.tar.gz 13:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:40 INFO - Installing collected packages: blessings 13:32:40 INFO - Running setup.py install for blessings 13:32:40 INFO - Successfully installed blessings 13:32:40 INFO - Cleaning up... 13:32:41 INFO - Return code: 0 13:32:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:41 INFO - Reading from file tmpfile_stdout 13:32:41 INFO - Current package versions: 13:32:41 INFO - argparse == 1.2.1 13:32:41 INFO - blessings == 1.6 13:32:41 INFO - blobuploader == 1.2.4 13:32:41 INFO - docopt == 0.6.1 13:32:41 INFO - functools32 == 3.2.3-2 13:32:41 INFO - jsonschema == 2.5.1 13:32:41 INFO - manifestparser == 1.1 13:32:41 INFO - mozInstall == 1.12 13:32:41 INFO - mozcrash == 0.17 13:32:41 INFO - mozdebug == 0.1 13:32:41 INFO - mozdevice == 0.48 13:32:41 INFO - mozfile == 1.2 13:32:41 INFO - mozhttpd == 0.7 13:32:41 INFO - mozinfo == 0.9 13:32:41 INFO - mozleak == 0.1 13:32:41 INFO - mozlog == 3.2 13:32:41 INFO - moznetwork == 0.27 13:32:41 INFO - mozprocess == 0.23 13:32:41 INFO - mozprofile == 0.28 13:32:41 INFO - mozrunner == 6.12 13:32:41 INFO - mozscreenshot == 0.1 13:32:41 INFO - mozsystemmonitor == 0.3 13:32:41 INFO - moztest == 0.7 13:32:41 INFO - mozversion == 1.4 13:32:41 INFO - psutil == 3.1.1 13:32:41 INFO - requests == 1.2.3 13:32:41 INFO - wsgiref == 0.1.2 13:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:41 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 13:32:41 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 13:32:41 INFO - Using env: {'DISPLAY': ':0', 13:32:41 INFO - 'HOME': '/home/cltbld', 13:32:41 INFO - 'LANG': 'en_US.UTF-8', 13:32:41 INFO - 'LANGUAGE': 'en_US:en', 13:32:41 INFO - 'LOGNAME': 'cltbld', 13:32:41 INFO - 'MAIL': '/var/mail/cltbld', 13:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:41 INFO - 'MOZ_NO_REMOTE': '1', 13:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:41 INFO - 'NO_EM_RESTART': '1', 13:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:41 INFO - 'PWD': '/builds/slave/test', 13:32:41 INFO - 'SHELL': '/bin/bash', 13:32:41 INFO - 'SHLVL': '1', 13:32:41 INFO - 'TERM': 'linux', 13:32:41 INFO - 'TMOUT': '86400', 13:32:41 INFO - 'USER': 'cltbld', 13:32:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:41 INFO - '_': '/tools/buildbot/bin/python'} 13:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 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)) 13:32:41 INFO - Cleaning up... 13:32:41 INFO - Return code: 0 13:32:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, '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': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', '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 13:32:41 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 13:32:41 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 13:32:41 INFO - Using env: {'DISPLAY': ':0', 13:32:41 INFO - 'HOME': '/home/cltbld', 13:32:41 INFO - 'LANG': 'en_US.UTF-8', 13:32:41 INFO - 'LANGUAGE': 'en_US:en', 13:32:41 INFO - 'LOGNAME': 'cltbld', 13:32:41 INFO - 'MAIL': '/var/mail/cltbld', 13:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:41 INFO - 'MOZ_NO_REMOTE': '1', 13:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:41 INFO - 'NO_EM_RESTART': '1', 13:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:41 INFO - 'PWD': '/builds/slave/test', 13:32:41 INFO - 'SHELL': '/bin/bash', 13:32:41 INFO - 'SHLVL': '1', 13:32:41 INFO - 'TERM': 'linux', 13:32:41 INFO - 'TMOUT': '86400', 13:32:41 INFO - 'USER': 'cltbld', 13:32:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:41 INFO - '_': '/tools/buildbot/bin/python'} 13:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:32:41 INFO - Cleaning up... 13:32:41 INFO - Return code: 0 13:32:41 INFO - Running post-action listener: _resource_record_post_action 13:32:41 INFO - Running post-action listener: _start_resource_monitoring 13:32:41 INFO - Starting resource monitoring. 13:32:41 INFO - ##### 13:32:41 INFO - ##### Finished create-virtualenv step (success) 13:32:41 INFO - ##### 13:32:41 INFO - ##### 13:32:41 INFO - ##### Running install step. 13:32:41 INFO - ##### 13:32:41 INFO - Running pre-action listener: _resource_record_pre_action 13:32:41 INFO - Running main action method: install 13:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:41 INFO - Reading from file tmpfile_stdout 13:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:42 INFO - Reading from file tmpfile_stdout 13:32:42 INFO - Output received: 13:32:42 INFO - Usage: mozinstall [options] installer 13:32:42 INFO - Options: 13:32:42 INFO - -h, --help show this help message and exit 13:32:42 INFO - -d DEST, --destination=DEST 13:32:42 INFO - Directory to install application into. [default: 13:32:42 INFO - "/builds/slave/test"] 13:32:42 INFO - --app=APP Application being installed. [default: firefox] 13:32:42 INFO - mkdir: /builds/slave/test/build/application 13:32:42 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'] 13:32:42 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 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Output received: 13:32:58 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:58 INFO - Running post-action listener: _resource_record_post_action 13:32:58 INFO - ##### 13:32:58 INFO - ##### Finished install step (success) 13:32:58 INFO - ##### 13:32:58 INFO - ##### 13:32:58 INFO - ##### Running run-tests step. 13:32:58 INFO - ##### 13:32:58 INFO - Running pre-action listener: _resource_record_pre_action 13:32:58 INFO - Running main action method: run_tests 13:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:58 INFO - Python 2.7.3 13:32:58 INFO - Return code: 0 13:32:58 INFO - grabbing minidump binary from tooltool 13:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:58 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 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:58 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 13:32:58 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 13:32:58 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 13:32:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:58 INFO - Return code: 0 13:32:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:32:58 INFO - Using env: {'DISPLAY': ':0', 13:32:58 INFO - 'HOME': '/home/cltbld', 13:32:58 INFO - 'LANG': 'en_US.UTF-8', 13:32:58 INFO - 'LANGUAGE': 'en_US:en', 13:32:58 INFO - 'LOGNAME': 'cltbld', 13:32:58 INFO - 'MAIL': '/var/mail/cltbld', 13:32:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:58 INFO - 'MOZ_NO_REMOTE': '1', 13:32:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:58 INFO - 'NO_EM_RESTART': '1', 13:32:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:58 INFO - 'PWD': '/builds/slave/test', 13:32:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:58 INFO - 'SHELL': '/bin/bash', 13:32:58 INFO - 'SHLVL': '1', 13:32:58 INFO - 'TERM': 'linux', 13:32:58 INFO - 'TMOUT': '86400', 13:32:58 INFO - 'USER': 'cltbld', 13:32:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468355358.971465-12512703', 13:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:58 INFO - '_': '/tools/buildbot/bin/python'} 13:32:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:32:58 INFO - mozversion application_buildid: 20160712125228 13:32:58 INFO - mozversion application_changeset: 1b779cb4e88190a365dab80a67299bbbdf883680 13:32:58 INFO - mozversion application_display_name: Nightly 13:32:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:58 INFO - mozversion application_name: Firefox 13:32:58 INFO - mozversion application_remotingname: firefox 13:32:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:32:58 INFO - mozversion application_vendor: Mozilla 13:32:58 INFO - mozversion application_version: 50.0a1 13:32:58 INFO - mozversion platform_buildid: 20160712125228 13:32:58 INFO - mozversion platform_changeset: 1b779cb4e88190a365dab80a67299bbbdf883680 13:32:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:32:58 INFO - mozversion platform_version: 50.0a1 13:32:58 INFO - using testdate: 1468355578 13:32:58 INFO - actual date: 1468355578 13:32:58 INFO - starting webserver on 'localhost:50959' 13:32:58 INFO - SUITE-START | Running 2 tests 13:32:58 INFO - TEST-START | dromaeo_css 13:32:58 INFO - operating with platform_type : linux_ 13:32:58 INFO - Initialising browser for dromaeo_css test... 13:32:58 INFO - TEST-INFO | started process 32296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6q3BD1/profile http://localhost:50959/getInfo.html) 13:33:02 INFO - PROCESS | 32296 | __metrics Screen width/height:1600/1200 13:33:02 INFO - PROCESS | 32296 | colorDepth:24 13:33:02 INFO - PROCESS | 32296 | Browser inner width/height: 1024/697 13:33:02 INFO - PROCESS | 32296 | __metrics 13:33:03 INFO - PROCESS | 32296 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:33:03 INFO - PROCESS | 32296 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:33:04 INFO - TEST-INFO | 32296: exit 0 13:33:04 INFO - Browser initialized. 13:33:04 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:04 INFO - TEST-INFO | started process 32378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6q3BD1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:16 INFO - PROCESS | 32378 | RSS: Main: 159109120 13:33:16 INFO - PROCESS | 32378 | 13:34:07 INFO - PROCESS | 32378 | 1468355647327 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] 13:36:20 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50959/tests/dromaeo/cssquery-ext.html) 13:36:21 INFO - PROCESS | 32378 | RSS: Main: 256548864 13:36:21 INFO - PROCESS | 32378 | 13:39:24 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-ext.html (next: http://localhost:50959/tests/dromaeo/cssquery-jquery.html) 13:39:25 INFO - PROCESS | 32378 | RSS: Main: 240205824 13:39:25 INFO - PROCESS | 32378 | 13:42:27 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50959/tests/dromaeo/cssquery-mootools.html) 13:42:27 INFO - PROCESS | 32378 | RSS: Main: 233758720 13:42:27 INFO - PROCESS | 32378 | 13:45:30 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50959/tests/dromaeo/cssquery-prototype.html) 13:45:30 INFO - PROCESS | 32378 | RSS: Main: 235200512 13:45:30 INFO - PROCESS | 32378 | 13:48:33 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50959/tests/dromaeo/cssquery-yui.html) 13:48:34 INFO - PROCESS | 32378 | RSS: Main: 217513984 13:48:34 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | Cycle 1(1): loaded http://localhost:50959/tests/dromaeo/cssquery-yui.html (next: http://localhost:50959/tests/dromaeo/cssquery-dojo.html) 13:51:37 INFO - PROCESS | 32378 | RSS: Main: 275357696 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | __start_tp_report 13:51:37 INFO - PROCESS | 32378 | _x_x_mozilla_page_load 13:51:37 INFO - PROCESS | 32378 | _x_x_mozilla_page_load_details 13:51:37 INFO - PROCESS | 32378 | |i|pagename|runs| 13:51:37 INFO - PROCESS | 32378 | |0;dojo.html;2613.751693589109;2613.8823752931116;2639.722829102944;2658.029819116022;2658.9895839580945;4656.79044443;4657.930131048032;4668.6731928765;4688.32019357193;4734.981978874542;4708.882277943053;4713.5993440557595;4784.306275590037;4797.208460603996;4813.302071199682;4098.631123198911;4274.187904298189;4362.149380870732;4384.013596940695;4497.370368148462;4412.867613971586;4451.132029254297;4469.0614970855995;4471.239889218824;4501.5273396293405;4266.3813747006825;4272.807723652443;4320.481542214923;4324.654027677778;4369.825206991716;4262.701610887239;4271.63691086258;4321.481422229353;4331.198728235287;4331.696781225315;4300.8709738707885;4337.132573485315;4351.5648435156545;4362.236608593484;4374.956250437519;4520.751358675271;4652.534746525354;4762.499937506546;4794.137055330039;4794.5205479452125;5112;5113.846584602468;5124.692518448905;5132.820351287724;5144.125498665236;4991.450940396553;5133.6149788765615;5168.8449346519665;5169.172932330846;5169.56058735008;4678.087772884289;4730.2668086445965;4731.550502702238;4757.26262429324;4796.400449943757;5207.531322181022;5218.478152184827;5243.68537887728;5245.186996015624;5245.239440281138;4887.218045112765;4962.5533701967;4974.37820272466;4991.625628077909;5001.149804533238;5017.172166592544;5067.543921047123;5093.617978651542;5139;5140.151874940668;5050.267711181858;5065.974670126626;5069.822556210515;5072.087024335581;5122.385313762298;4889.853304400874;4921.9507804922205;4993.325901003391;5027.572656324253;5035.571976382049;4275.337322714984;4288.957110428856;4322.502912165079;4329.653627709776;4332.501762297376;3740.270647223765;3758.530183727034;3763.34141525232;3801.961980380216;3813.9618603813606;4322.805473753689;4363.410939523187;4364.039911219526;4395.142947125344;4403.911921761611;5096.9490305097215;5109.335786347751;5127.717975511308;5133.383993920754;5178.171492561172;4420.513743488214;4427.468703755506;4432.3794668746405;4477.104579084131;4480.977595112004;4436.0462500562535;4477.686561940633;4477.753723545171;4592.471865735483;4601.332806743004;4720.362751028636;4771.498992605726;4783.6651434399255;4787.712737235777;4827.275908613736;5054.393472783289;5098.286239926488;5101.540861322499;5102.387713474407;5133.974330128325;4692;4715.434147902273;4739.526047395233;4790.904181916412;4854.19905715553;4994.675346102492;5000.599952003904;5010.073136469765;5025.7989680412375;5026.59787217029;5016.949830501649;5083.110455670169;5086.21163719624;5157.7679004444135;5160.922586161136;4963.975180124221;4971.229459433794;4974.751262436791;4977.477364876636;5020.246962955586;4954.851354459372;4965.677230979974;4966.106100901728;4967.304577359245;5003.974980125076;4749.311349854321;4788.904221915473;4843.685160464559;4849.418069831501;4917.926231106465;4974.900501989868;4977.9751101244265;4980.028894365564;4985.252212168204;4993.076280888047;4710.882227944328;4813.831515897067;4862.07620552094;4872.293517439881;4877.829275975324 13:51:37 INFO - PROCESS | 32378 | |1;ext.html;547.3764562959929;562.7439515020664;573.9725890655726;581.0499832773415;597.1281928384558;26509.33726656832;40855;41801.16397672045;41897.16205675885;41951;42151.78924105375;42659.573404265946;42760;42767.78616106923;42773.786131069304;7763.728269510569;7856.4893281936775;7985.600719964008;10116.14012808912;10408.583656653725;10277.897221027806;10383.532741026673;10390.116840068604;10393.896061039368;10394.480275986209;10432.165426765841;10482.737931551734;10490.737731556696;10491.37051776892;10492.317999330056;7646.732364367221;10073.44596047217;10303.072723454925;10330.845037324447;10667.199960002954;10180.287379883412;10233.130183934374;10234.79530409395;10242.385456872536;10255.384676919333;30562.235944101354;40428.59571404278;40730.57442989511;40784;40877.59122408797;2808.592754050672;2838.758705510034;2918.2996080940634;2923.283795470102;3071.0633256856872;29372.11883643494;29647.258818529495;30649.690883289863;31002;31784.205394865083;3518.7888726676483;3523.788572685647;3600.6399360064047;3614.150674591469;3671.4492826076034;268732;274759;274950;276294.6185269081;276593;48204.27693584599;56076.43923560712;57685.134722979186;57766;63846.36153638497;61172.38827611667;61184.38815611876;61410.69294653498;61469;61592;12609.180403273758;13446.865531344562;13506.324683765772;13522.729545409233;13538.932305338607;10645.148388128931;10972.341659500455;10979.1765617579;12241.449134788778;12260.938695306466;19336.226550938085;19370.5157371064;19395.3211637592;19407.611847762964;19415.514612134528;7077.9646101770195;7113.181984071794;7174.3184397482155;7274.527155734861;7431.479796414199;781.2773184804033;889.2752406788446;935.5649622925372;958.4153666263574;962.4369743699874;29103.56344654832;29294.414111717648;29385;29620.703792962224;30035.399292014037;1011.5903059261011;1024.4928760263567;1047.9939258312106;1057.534684738728;1079.3038490173794;15036;15122.017068890487;15475.767863482057;15613.0449982521;15635.3745850167;439831;443417;443839;444034;448097;51247.231291530654;51912.48087519152;51982;52007;52070;1054.6466933577185;1117.8211486162013;1180.6576092933296;1200.8318835363057;1212.9393530323448;27042.864785675945;29220.853895730386;29874.402511950073;30325.39349212959;30464.84767576148;42810;43143.56856431521;43331;43343.56656433395;43372.34941475817;304211;305689;305781;305832;306500;25529.87235063813;26864.194074177805;26871.193864184104;27925.44149117047;38765.41851872281;39638.405423918084;39805.601943981346;40346.79826600848;40600.79699601483;41187;34466.82766586151;34867.47698784571;35225.29549409049;35529.28941421105;35745.463818043274;35079.649203508656;35566.466503002994;35613.64386356103;35771.28457430889;35782.4632630516;34736.82631586826;34843;34939.82530087333;35508.82245588755;35712.10719732028;31263.218419538785;31405.476658293697;31888.36223275568;31977.840110799298;32127.83936080398;24464.388390289674;24745.25764227076;24760.754204585934;25009;25011.749882500942 13:51:37 INFO - PROCESS | 32378 | |2;jquery.html;346.58063742871127;372.3929994109601;372.9850805967761;374.5449279125862;380.43885269227894;12873.420696068675;16424.91787541062;16792.74810877835;16969.575760605992;17950.64098718025;16607.50177494677;17050.658986820286;17245.051522166308;17313.30746770131;17571.29714811406;4545.181867263891;5124.9487505124935;5350.5184533391985;5358.812441564546;5361.356637203541;5257.36911570612;5313;5314.9468505314835;5323.41442441333;5324.494173053554;5153.123968925273;5180.222966555009;5228.869278268055;5230.973845130769;5240.973795131019;5157.922631160535;5211.973940130275;5217.087009773274;5218.660787048849;5219.921701174486;4418.977905110486;4662.090892276007;4664.253719404879;4668.929966050512;4673.976630116862;20383.592328153354;20691.27580534674;21007.894960525253;21120.577588448145;21216.36350909475;2049.1496029147884;2282.9200977965693;2347.7417484076736;2401.951960960771;2469.8888550015295;12659;13270.137441066396;13308.201507909556;13675.521356752566;13741.312934353242;1693.517347555953;1745.5287072490357;1783.678937791197;1791.426743442099;1803.8196180381988;69488;70581.64709176472;72852.63573682151;73003.63498182528;73498;8462.576871156418;9097.1812536872;9416.293777966679;9558.665446709332;9646.614135434504;12006.87993120075;12788.424520896582;12881.291528965809;13360.06479546442;13372.130811497222;7129.536580122275;7405.666744996488;7506.512076714996;7512.962435187898;7552;6872.278410766898;6894.965525172342;7057.223705392403;7118.857622847514;7226.421886249087;5770.365259821417;6007.579469437185;6053.364396738367;6165.568410211242;6198.6280823150755;1708.3593652380357;1718.4500959693028;1727.6631056943775;1776.9200385982663;1827.1047186878334;862.6247582301719;876.9517676527852;906.6282824042111;991.1377101921374;1012.7366884610054;16582.58543536397;17310.567235818955;17471.475855724348;17559.20983555743;17789.644207115784;860.2730692564772;870.6778491957889;874.4097734029505;934.63082082577;947.6825263536655;9660;9749.756256093513;9775.169110625677;9911;9924.40453572788;352285.3400261957;373700;374020;377020;377887;72218;72548.63725681338;72910;73035;74399.62800185964;887.5917078143997;890.7728529225006;896.4397251717677;910.5947853205392;936.7658085478494;11877.249100359924;15844.584323869118;16058.437954671997;16364.181790910645;16576.917115414344;37908.241835163695;37909.62090379061;37982;38479;38552.22895542017;45978;47504.52495475001;47527.52472475231;47763;47912.28131578099;7624.69501219945;7643.503172293783;7666.350258675797;7694.461387702807;7867.9606601966625;10892.736676411254;11619.883801161881;11635;11962.401879905796;12112.45493952792;10023.498825058863;10125;10417.270791044553;10608.734781630521;10754.085902698358;10011.149052330633;10039.849402259119;10064.597416103274;10198.33710808795;10447.94776026115;10242.129418999171;10332.586696532355;10712.464376780974;10798.622048228275;11021.944890275498;7726.961365193138;7747.147813740597;7777.144514103331;7835.098963619257;7934.404919631166;9649.951750241204;10420.531076101744;10479.371237725762;10748.946255268673;10909.563617455213 13:51:37 INFO - PROCESS | 32378 | |3;mootools.html;1347.9595612131639;1364.3587513868483;1452.2158034661284;1655.710250706126;1674.5227610131114;7177.174624918136;7492.100947886248;7624.046994125734;7624.085109786826;7628.771136865896;6348.968255158729;7039.7536086237;7281.453890958172;7289.854202915939;7500.39996800256;2173.0981642618294;2202.152171414009;2203.8787866667326;2204.206485665159;2207.426069222006;1883.1808163448875;2223.6998005269324;2230.565039817236;2258.503129311549;2259.2318611672026;2120;2202.8898555072265;2213.8118259947923;2229.0972156276734;2233.575620632075;2150.064721846002;2158.1151727791607;2163.5240247145603;2165.4802847316687;2224.922127725522;2165.935021949344;2214.1586197245106;2218.0129842220217;2218.0794970087395;2218.7781221877844;7539.170691223961;7576.356009739179;7578.621068946586;7579.734709285149;7581.507202031906;4363.280058790296;4466;4473.083017981338;4478.328250762379;4484.708493947883;2791.288221503524;2824.915252542427;2918.3433727411375;2931.120663800851;2931.399063192062;883.2139395937621;909.5406819556082;917.289100946765;918.3755046568331;919.7286800393833;9491.19324857388;9506.096920792583;9516.904830951671;9517.762055948588;9520.761980950463;3961.187956468917;4044.9797751011056;4149.875503734893;4210.073783767628;4219.831206751695;8251.628676709563;8315.417920745489;8319.500829950222;8320.750377488685;8325.542095184823;4454.510003899569;4461.152381047591;4464.419625448671;4465.843695470643;4469.128519938581;4013.7993100344866;4069.2471892699946;4073.3889916512167;4075.3683179107284;4078.1232035112594;3585.4263317869536;3620.637936206411;3641.6358364163902;3673.8163091845836;3682.2819550187455;1026.4918865161792;1181.9113566482376;1196.904247660185;1199.9520019199308;1210.2919791921825;612.7855250662233;750.2272659161073;820.8029724224114;820.9630566624517;829.5520418973807;4812.283121163425;5071.137906555894;5092.414372347153;5115.283860259567;5140.280360749498;818.7830224990382;867.800405906645;876.2157868707471;877.972771856929;897.2194191053825;3403.2002479417315;3451.4132597458492;3460.532828068229;3467.7052450541987;3503.474478828196;8709.912900871037;9336.813263734688;9351.251899847995;9358.298127640453;9366.157045865904;9061.59222834974;9183.90816091844;9196.12636799503;9197.724068277963;9233.90766092344;6661.2006559213205;6981.476389270825;6995.685194166274;7125.859862421988;7133.322334378226;4936.75316234194;4950.45544990058;5008.248762685626;5052.72210028452;5069.391672999263;8309.418340716093;8351.791205219675;8588.398812083095;8599.484030958163;8605.483670979762;8485.787855303666;8638.26574741154;8670.046294907681;8788.42875213109;8795.032546419761;6503.837404064936;6577.835554111186;6605.867882642417;6611.504137189826;6645.568038077509;7065.22282548909;7178.4257259420165;7248;7255.09311336083;7255.2019277880445;4879.463259041431;6577.210734711865;6609.405153536205;6733.0573719678305;6815.182178138655;6495.707693153914;6544.345565443417;6548.705308261045;6570.507211959027;6592.901106483502;5494;5748.080307150836;5757.798477053283;5844.707764611668;5844.883102337844;4248.830046798217;4266.06146647737;4285.657147428261;4344.8044837983;4377.6497880170145;4322.546132656152;4420.403245561808;4451.065276292015;4479.238529449936;4538.591526762607 13:51:37 INFO - PROCESS | 32378 | |4;prototype.html;291.1193639241295;299.3085971406052;299.94451026560085;301.9199912023313;305.68209062574925;4909;4921.8523444296725;4927.556519913207;4935.087008903355;4962.602991760659;4805.447373552042;4814.807407703687;4841.419029716439;4849.781759820808;4853.830115945942;3607.1883826139106;3741.6904083570803;3750;3851.73037887348;3855.595162507924;3843.730938834283;3844.4809950656722;3848.615138486157;3860.498135242429;3876.592957739439;3633.273345330931;3761.3417651910945;3795.601461846508;3831.157145428015;3841.673457756094;3748.418995055757;3817.618238176188;3837.021559502309;3855.7108216883566;3861.4787003754413;3390.6609339066144;3398.7764404814247;3398.7790793598583;3416.8462419191196;3424.5376874121926;4771.832985845514;4784.727254554094;4788.138135135674;4796.304535842318;4803.78382972767;4242.172776308621;4413.249747542894;4413.9254550361275;4417.917610185493;4425.845095421645;5029.748512574393;5081.517255860687;5092;5098.444974282842;5107.438181799999;3744.2511497700298;3745.700343972476;3753.6997040236715;3757.248550289953;3760.304343696425;5201.24581935621;5287.68273903567;5340.572754179656;5371.167469042305;5371.355437347544;3797.9810100949317;3800.7909564974193;3803.505544279226;3813.5614404343855;3815.6756675682877;3867.8646247381207;3873.3802591585213;3874.8256328465286;3887.5723670396233;3889.183271512957;4375.606195442426;4398.494173170063;4400.185965596375;4404.11917616478;4417.712848664826;4882.707037577757;5078.898422031539;5080.59355251579;5086.2960908095465;5127.589792816566;1280.3982128399637;1304.4390911907972;1305.9804102938463;1307.6730817295677;1311.2460335307237;835.1940377535707;841.1840514700731;866.4757821517891;897.717219075989;897.9673375618091;4469.888252793706;4492.752898590609;4501.347304640809;4507.143642707941;4514.593686568224;5160.767765450564;5200.947990520122;5202.08963431398;5240.187770895517;5254.632175747661;4351.82592696295;4488.236999710057;4503.392042074278;4520.841770538015;4572;2793.483205606969;2819.732125448079;2827.787915906274;2832.589274555178;2834.67401248859;5005.27423523587;5018.272350509155;5028.723420211851;5030.89938201234;5033.295338652591;5164.896702066013;5435.239066530688;5458.918116228259;5482.698451585201;5524.447555244524;5014.690304399079;5014.974925125351;5024.221245706921;5027.472115427828;5033.144365457881;5312.495312945264;5324.6006549508165;5327.9467205329;5354.437784032621;5392.325959255093;5093.770780314969;5101.285819985131;5161.612879034013;5167.948320516747;5181;4936.901261974812;4966.453690094159;4972.825951091694;4978.626603004862;4978.925316120189;3782.829772660182;3787.4129509926006;3795.9430608540342;3814.942775858309;3818.16000479894;5129.692218466904;5289.7355132244;5324.840254792362;5335.813246536508;5372.489613486712;5102.66832655891;5108.66793658411;5119.385673719177;5134.820281290137;5138.897222055463;5125.2568377585785;5126.564242039469;5134.512221338967;5150.1502252127975;5161.638685291993;4822.987172693774;4934.481879402611;5047.848564543069;5069.504496173711;5080.339555857715;5003.249512572997;5133.922991155061;5166;5189.532942035235;5196.298499702491;5043.218301163325;5050.469700681522;5099.056674515226;5107.79568817258;5118.6947328431015 13:51:37 INFO - PROCESS | 32378 | |5;yui.html;641.3778634724317;649.4804156674661;672.9562578432405;698.4691634357887;734.3317581001284;12962.675933101676;13472.865271347284;13584.592462226125;13622.659433514167;13639.659008524779;13678.52125175619;14331;14397.352119154637;14874.405023799036;14901.956863019594;783.9490433121844;801.3789313282194;801.4029547986758;804.6178065418909;804.9114597394282;624.2134910013393;763.5151678684048;794.4041968523608;794.5788731972063;796.410656114474;828.958552072397;834.4450940124809;835.0980940584185;835.5655059369154;837.530982649715;647.7085311609748;828.3125006244802;828.5111784047441;828.6892415344277;829.0672992883007;589.4606435111867;610.188449362347;610.4658423879106;610.6580315023557;613.2150846915955;13520.661983450394;13606.251656158907;13614.727705445835;13617.387217575233;13630.1140425872;12226.449809758582;12742.872571274262;12823.74352512954;12868.871311286954;13002.414891329912;11741.952894259462;12121.27272363661;12253.938730306381;12467.314297713621;12870.67823304425;4096.221717873595;4105.712600117993;4122.093139509303;4242.342436922282;4275.786210689453;62031.379686203014;62372;62656;62838;64324.678376607815;10087.798244035079;10340.172786177087;10350.844737328945;10364.844527332096;10374;17894.5526361842;19108.713369299472;19124.33064842724;19134.23463061462;19169.904150479437;6523.804285871432;6657.633830139389;6696.8995465068065;7024.332688394697;7110.360067593838;3722.4602432647116;3785.37541305687;3810.866619668354;3868.574456809749;3873.070463088895;2664.3472349274552;2755.2698534888273;2784.721527847199;2785.1644506647926;2785.582162675574;511.3250509327652;513.5891286970409;523.0924346259237;527.9076161671692;529.9205119232068;572.9914051289234;592.1739173852452;595.5057302438966;597.4831770518471;613.1385403508078;8253.422260441712;8341.582920853933;8546.188112129337;8640.611172497252;8703.869441958375;548.9396166421691;592.6918002638604;604.3412680178538;611.078159189347;623.1774058243076;4240.893977650583;4269.807858646368;4363.236433624166;4419.403380543586;4513.774311284488;90347.54826225826;92272.07727922768;94099;94510.52744736233;94707.52646236862;83343;83388.58305708555;83703.58148209342;83763.32473350498;84309.57845210857;44456.55543444589;66760;70433.6478317605;72743;73596.63201683958;8304.6678132874;9096.636134554808;9141.817163656557;9214.631414743335;9488.193503552275;34533.65466345405;42679;43179.78410107929;44154;46181.76909115433;44772.77613611911;65056;65268.67365663331;65315.34684653093;67056.66471667611;11265.831012534654;11469.655910322703;11540.422978850856;11944.104192185447;12083.818742718691;13417.194968301934;13597.79603305971;13651.522196723066;13911.652208694864;14461.85538144605;11955.103367247317;12084.92430207841;12452.08815778971;12894.871051289367;13268;12813.295268760308;13036.804447933479;13280.601581952556;13370.598882033555;13717.862821372059;12057.216280941711;12084.637460876187;12371.195872268274;12717.236965782082;12847.743045139232;9387.577559009998;9421.340506164777;9527.666531671359;9698.85451718239;10273.897261027294;9912.15746661542;10350.964903509588;10469.9476502617;10498.895011049792;10588.841167382341 13:51:37 INFO - PROCESS | 32378 | __end_tp_report 13:51:37 INFO - PROCESS | 32378 | __start_cc_report 13:51:37 INFO - PROCESS | 32378 | _x_x_mozilla_cycle_collect,1000 13:51:37 INFO - PROCESS | 32378 | __end_cc_report 13:51:37 INFO - PROCESS | 32378 | __startTimestamp1468356697564__endTimestamp 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | ------- Summary: start ------- 13:51:37 INFO - PROCESS | 32378 | Number of tests: 6 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#0] dojo.html Cycles:165 Average:4689.31 Median:4794.52 stddev:498.17 (10.4%) stddev-sans-first:472.34 13:51:37 INFO - PROCESS | 32378 | Values: 2613.8 2613.9 2639.7 2658.0 2659.0 4656.8 4657.9 4668.7 4688.3 4735.0 4708.9 4713.6 4784.3 4797.2 4813.3 4098.6 4274.2 4362.1 4384.0 4497.4 4412.9 4451.1 4469.1 4471.2 4501.5 4266.4 4272.8 4320.5 4324.7 4369.8 4262.7 4271.6 4321.5 4331.2 4331.7 4300.9 4337.1 4351.6 4362.2 4375.0 4520.8 4652.5 4762.5 4794.1 4794.5 5112.0 5113.8 5124.7 5132.8 5144.1 4991.5 5133.6 5168.8 5169.2 5169.6 4678.1 4730.3 4731.6 4757.3 4796.4 5207.5 5218.5 5243.7 5245.2 5245.2 4887.2 4962.6 4974.4 4991.6 5001.1 5017.2 5067.5 5093.6 5139.0 5140.2 5050.3 5066.0 5069.8 5072.1 5122.4 4889.9 4922.0 4993.3 5027.6 5035.6 4275.3 4289.0 4322.5 4329.7 4332.5 3740.3 3758.5 3763.3 3802.0 3814.0 4322.8 4363.4 4364.0 4395.1 4403.9 5096.9 5109.3 5127.7 5133.4 5178.2 4420.5 4427.5 4432.4 4477.1 4481.0 4436.0 4477.7 4477.8 4592.5 4601.3 4720.4 4771.5 4783.7 4787.7 4827.3 5054.4 5098.3 5101.5 5102.4 5134.0 4692.0 4715.4 4739.5 4790.9 4854.2 4994.7 5000.6 5010.1 5025.8 5026.6 5016.9 5083.1 5086.2 5157.8 5160.9 4964.0 4971.2 4974.8 4977.5 5020.2 4954.9 4965.7 4966.1 4967.3 5004.0 4749.3 4788.9 4843.7 4849.4 4917.9 4974.9 4978.0 4980.0 4985.3 4993.1 4710.9 4813.8 4862.1 4872.3 4877.8 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#1] ext.html Cycles:180 Average:50128.28 Median:31132.61 stddev:92090.09 (295.8%) stddev-sans-first:92273.18 13:51:37 INFO - PROCESS | 32378 | Values: 547.4 562.7 574.0 581.0 597.1 26509.3 40855.0 41801.2 41897.2 41951.0 42151.8 42659.6 42760.0 42767.8 42773.8 7763.7 7856.5 7985.6 10116.1 10408.6 10277.9 10383.5 10390.1 10393.9 10394.5 10432.2 10482.7 10490.7 10491.4 10492.3 7646.7 10073.4 10303.1 10330.8 10667.2 10180.3 10233.1 10234.8 10242.4 10255.4 30562.2 40428.6 40730.6 40784.0 40877.6 2808.6 2838.8 2918.3 2923.3 3071.1 29372.1 29647.3 30649.7 31002.0 31784.2 3518.8 3523.8 3600.6 3614.2 3671.4 268732.0 274759.0 274950.0 276294.6 276593.0 48204.3 56076.4 57685.1 57766.0 63846.4 61172.4 61184.4 61410.7 61469.0 61592.0 12609.2 13446.9 13506.3 13522.7 13538.9 10645.1 10972.3 10979.2 12241.4 12260.9 19336.2 19370.5 19395.3 19407.6 19415.5 7078.0 7113.2 7174.3 7274.5 7431.5 781.3 889.3 935.6 958.4 962.4 29103.6 29294.4 29385.0 29620.7 30035.4 1011.6 1024.5 1048.0 1057.5 1079.3 15036.0 15122.0 15475.8 15613.0 15635.4 439831.0 443417.0 443839.0 444034.0 448097.0 51247.2 51912.5 51982.0 52007.0 52070.0 1054.6 1117.8 1180.7 1200.8 1212.9 27042.9 29220.9 29874.4 30325.4 30464.8 42810.0 43143.6 43331.0 43343.6 43372.3 304211.0 305689.0 305781.0 305832.0 306500.0 25529.9 26864.2 26871.2 27925.4 38765.4 39638.4 39805.6 40346.8 40600.8 41187.0 34466.8 34867.5 35225.3 35529.3 35745.5 35079.6 35566.5 35613.6 35771.3 35782.5 34736.8 34843.0 34939.8 35508.8 35712.1 31263.2 31405.5 31888.4 31977.8 32127.8 24464.4 24745.3 24760.8 25009.0 25011.7 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#2] jquery.html Cycles:180 Average:23811.99 Median:4482.08 stddev:61303.90 (1367.8%) stddev-sans-first:61450.56 13:51:37 INFO - PROCESS | 32378 | Values: 346.6 372.4 373.0 374.5 380.4 12873.4 16424.9 16792.7 16969.6 17950.6 16607.5 17050.7 17245.1 17313.3 17571.3 4545.2 5124.9 5350.5 5358.8 5361.4 5257.4 5313.0 5314.9 5323.4 5324.5 5153.1 5180.2 5228.9 5231.0 5241.0 5157.9 5212.0 5217.1 5218.7 5219.9 4419.0 4662.1 4664.3 4668.9 4674.0 20383.6 20691.3 21007.9 21120.6 21216.4 2049.1 2282.9 2347.7 2402.0 2469.9 12659.0 13270.1 13308.2 13675.5 13741.3 1693.5 1745.5 1783.7 1791.4 1803.8 69488.0 70581.6 72852.6 73003.6 73498.0 8462.6 9097.2 9416.3 9558.7 9646.6 12006.9 12788.4 12881.3 13360.1 13372.1 7129.5 7405.7 7506.5 7513.0 7552.0 6872.3 6895.0 7057.2 7118.9 7226.4 5770.4 6007.6 6053.4 6165.6 6198.6 1708.4 1718.5 1727.7 1776.9 1827.1 862.6 877.0 906.6 991.1 1012.7 16582.6 17310.6 17471.5 17559.2 17789.6 860.3 870.7 874.4 934.6 947.7 9660.0 9749.8 9775.2 9911.0 9924.4 352285.3 373700.0 374020.0 377020.0 377887.0 72218.0 72548.6 72910.0 73035.0 74399.6 887.6 890.8 896.4 910.6 936.8 11877.2 15844.6 16058.4 16364.2 16576.9 37908.2 37909.6 37982.0 38479.0 38552.2 45978.0 47504.5 47527.5 47763.0 47912.3 7624.7 7643.5 7666.4 7694.5 7868.0 10892.7 11619.9 11635.0 11962.4 12112.5 10023.5 10125.0 10417.3 10608.7 10754.1 10011.1 10039.8 10064.6 10198.3 10447.9 10242.1 10332.6 10712.5 10798.6 11021.9 7727.0 7747.1 7777.1 7835.1 7934.4 9650.0 10420.5 10479.4 10748.9 10909.6 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#3] mootools.html Cycles:180 Average:4915.53 Median:5317.14 stddev:2675.12 (50.3%) stddev-sans-first:2669.19 13:51:37 INFO - PROCESS | 32378 | Values: 1348.0 1364.4 1452.2 1655.7 1674.5 7177.2 7492.1 7624.0 7624.1 7628.8 6349.0 7039.8 7281.5 7289.9 7500.4 2173.1 2202.2 2203.9 2204.2 2207.4 1883.2 2223.7 2230.6 2258.5 2259.2 2120.0 2202.9 2213.8 2229.1 2233.6 2150.1 2158.1 2163.5 2165.5 2224.9 2165.9 2214.2 2218.0 2218.1 2218.8 7539.2 7576.4 7578.6 7579.7 7581.5 4363.3 4466.0 4473.1 4478.3 4484.7 2791.3 2824.9 2918.3 2931.1 2931.4 883.2 909.5 917.3 918.4 919.7 9491.2 9506.1 9516.9 9517.8 9520.8 3961.2 4045.0 4149.9 4210.1 4219.8 8251.6 8315.4 8319.5 8320.8 8325.5 4454.5 4461.2 4464.4 4465.8 4469.1 4013.8 4069.2 4073.4 4075.4 4078.1 3585.4 3620.6 3641.6 3673.8 3682.3 1026.5 1181.9 1196.9 1200.0 1210.3 612.8 750.2 820.8 821.0 829.6 4812.3 5071.1 5092.4 5115.3 5140.3 818.8 867.8 876.2 878.0 897.2 3403.2 3451.4 3460.5 3467.7 3503.5 8709.9 9336.8 9351.3 9358.3 9366.2 9061.6 9183.9 9196.1 9197.7 9233.9 6661.2 6981.5 6995.7 7125.9 7133.3 4936.8 4950.5 5008.2 5052.7 5069.4 8309.4 8351.8 8588.4 8599.5 8605.5 8485.8 8638.3 8670.0 8788.4 8795.0 6503.8 6577.8 6605.9 6611.5 6645.6 7065.2 7178.4 7248.0 7255.1 7255.2 4879.5 6577.2 6609.4 6733.1 6815.2 6495.7 6544.3 6548.7 6570.5 6592.9 5494.0 5748.1 5757.8 5844.7 5844.9 4248.8 4266.1 4285.7 4344.8 4377.6 4322.5 4420.4 4451.1 4479.2 4538.6 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#4] prototype.html Cycles:180 Average:4272.18 Median:4868.27 stddev:1233.88 (25.3%) stddev-sans-first:1200.61 13:51:37 INFO - PROCESS | 32378 | Values: 291.1 299.3 299.9 301.9 305.7 4909.0 4921.9 4927.6 4935.1 4962.6 4805.4 4814.8 4841.4 4849.8 4853.8 3607.2 3741.7 3750.0 3851.7 3855.6 3843.7 3844.5 3848.6 3860.5 3876.6 3633.3 3761.3 3795.6 3831.2 3841.7 3748.4 3817.6 3837.0 3855.7 3861.5 3390.7 3398.8 3398.8 3416.8 3424.5 4771.8 4784.7 4788.1 4796.3 4803.8 4242.2 4413.2 4413.9 4417.9 4425.8 5029.7 5081.5 5092.0 5098.4 5107.4 3744.3 3745.7 3753.7 3757.2 3760.3 5201.2 5287.7 5340.6 5371.2 5371.4 3798.0 3800.8 3803.5 3813.6 3815.7 3867.9 3873.4 3874.8 3887.6 3889.2 4375.6 4398.5 4400.2 4404.1 4417.7 4882.7 5078.9 5080.6 5086.3 5127.6 1280.4 1304.4 1306.0 1307.7 1311.2 835.2 841.2 866.5 897.7 898.0 4469.9 4492.8 4501.3 4507.1 4514.6 5160.8 5200.9 5202.1 5240.2 5254.6 4351.8 4488.2 4503.4 4520.8 4572.0 2793.5 2819.7 2827.8 2832.6 2834.7 5005.3 5018.3 5028.7 5030.9 5033.3 5164.9 5435.2 5458.9 5482.7 5524.4 5014.7 5015.0 5024.2 5027.5 5033.1 5312.5 5324.6 5327.9 5354.4 5392.3 5093.8 5101.3 5161.6 5167.9 5181.0 4936.9 4966.5 4972.8 4978.6 4978.9 3782.8 3787.4 3795.9 3814.9 3818.2 5129.7 5289.7 5324.8 5335.8 5372.5 5102.7 5108.7 5119.4 5134.8 5138.9 5125.3 5126.6 5134.5 5150.2 5161.6 4823.0 4934.5 5047.8 5069.5 5080.3 5003.2 5133.9 5166.0 5189.5 5196.3 5043.2 5050.5 5099.1 5107.8 5118.7 13:51:37 INFO - PROCESS | 32378 | 13:51:37 INFO - PROCESS | 32378 | [#5] yui.html Cycles:180 Average:17610.69 Median:25347.77 stddev:24318.57 (95.9%) stddev-sans-first:24353.41 13:51:37 INFO - PROCESS | 32378 | Values: 641.4 649.5 673.0 698.5 734.3 12962.7 13472.9 13584.6 13622.7 13639.7 13678.5 14331.0 14397.4 14874.4 14902.0 783.9 801.4 801.4 804.6 804.9 624.2 763.5 794.4 794.6 796.4 829.0 834.4 835.1 835.6 837.5 647.7 828.3 828.5 828.7 829.1 589.5 610.2 610.5 610.7 613.2 13520.7 13606.3 13614.7 13617.4 13630.1 12226.4 12742.9 12823.7 12868.9 13002.4 11742.0 12121.3 12253.9 12467.3 12870.7 4096.2 4105.7 4122.1 4242.3 4275.8 62031.4 62372.0 62656.0 62838.0 64324.7 10087.8 10340.2 10350.8 10364.8 10374.0 17894.6 19108.7 19124.3 19134.2 19169.9 6523.8 6657.6 6696.9 7024.3 7110.4 3722.5 3785.4 3810.9 3868.6 3873.1 2664.3 2755.3 2784.7 2785.2 2785.6 511.3 513.6 523.1 527.9 529.9 573.0 592.2 595.5 597.5 613.1 8253.4 8341.6 8546.2 8640.6 8703.9 548.9 592.7 604.3 611.1 623.2 4240.9 4269.8 4363.2 4419.4 4513.8 90347.5 92272.1 94099.0 94510.5 94707.5 83343.0 83388.6 83703.6 83763.3 84309.6 44456.6 66760.0 70433.6 72743.0 73596.6 8304.7 9096.6 9141.8 9214.6 9488.2 34533.7 42679.0 43179.8 44154.0 46181.8 44772.8 65056.0 65268.7 65315.3 67056.7 11265.8 11469.7 11540.4 11944.1 12083.8 13417.2 13597.8 13651.5 13911.7 14461.9 11955.1 12084.9 12452.1 12894.9 13268.0 12813.3 13036.8 13280.6 13370.6 13717.9 12057.2 12084.6 12371.2 12717.2 12847.7 9387.6 9421.3 9527.7 9698.9 10273.9 9912.2 10351.0 10469.9 10498.9 10588.8 13:51:37 INFO - PROCESS | 32378 | -------- Summary: end -------- 13:51:37 INFO - PROCESS | 32378 | 13:51:38 INFO - TEST-INFO | 32378: exit 0 13:51:38 INFO - TEST-OK | dromaeo_css | took 1119812ms 13:51:38 INFO - TEST-START | kraken 13:51:38 INFO - operating with platform_type : linux_ 13:51:38 INFO - Initialising browser for kraken test... 13:51:38 INFO - TEST-INFO | started process 32567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKA9eWP/profile http://localhost:50959/getInfo.html) 13:51:42 INFO - PROCESS | 32567 | __metrics Screen width/height:1600/1200 13:51:42 INFO - PROCESS | 32567 | colorDepth:24 13:51:42 INFO - PROCESS | 32567 | Browser inner width/height: 1024/697 13:51:42 INFO - PROCESS | 32567 | __metrics 13:51:43 INFO - PROCESS | 32567 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:51:43 INFO - PROCESS | 32567 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:51:44 INFO - TEST-INFO | 32567: exit 0 13:51:44 INFO - Browser initialized. 13:51:44 INFO - Running cycle 1/1 for kraken test... 13:51:44 INFO - TEST-INFO | started process 32646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKA9eWP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:56 INFO - PROCESS | 32646 | RSS: Main: 159248384 13:51:56 INFO - PROCESS | 32646 | 13:51:58 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50959/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:59 INFO - PROCESS | 32646 | RSS: Main: 217280512 13:51:59 INFO - PROCESS | 32646 | 13:52:02 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50959/tests/kraken/driver.html?testName=audio-dft) 13:52:03 INFO - PROCESS | 32646 | RSS: Main: 204595200 13:52:03 INFO - PROCESS | 32646 | 13:52:06 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50959/tests/kraken/driver.html?testName=audio-fft) 13:52:07 INFO - PROCESS | 32646 | RSS: Main: 271151104 13:52:07 INFO - PROCESS | 32646 | 13:52:09 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50959/tests/kraken/driver.html?testName=audio-oscillator) 13:52:09 INFO - PROCESS | 32646 | RSS: Main: 182099968 13:52:09 INFO - PROCESS | 32646 | 13:52:12 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:12 INFO - PROCESS | 32646 | RSS: Main: 185937920 13:52:12 INFO - PROCESS | 32646 | 13:52:15 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50959/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:16 INFO - PROCESS | 32646 | RSS: Main: 222289920 13:52:16 INFO - PROCESS | 32646 | 13:52:20 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50959/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:20 INFO - PROCESS | 32646 | RSS: Main: 223363072 13:52:20 INFO - PROCESS | 32646 | 13:52:23 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50959/tests/kraken/driver.html?testName=json-parse-financial) 13:52:24 INFO - PROCESS | 32646 | RSS: Main: 222830592 13:52:24 INFO - PROCESS | 32646 | 13:52:25 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:26 INFO - PROCESS | 32646 | RSS: Main: 208596992 13:52:26 INFO - PROCESS | 32646 | 13:52:28 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:28 INFO - PROCESS | 32646 | RSS: Main: 212733952 13:52:28 INFO - PROCESS | 32646 | 13:52:31 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:31 INFO - PROCESS | 32646 | RSS: Main: 210898944 13:52:31 INFO - PROCESS | 32646 | 13:52:34 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:35 INFO - PROCESS | 32646 | RSS: Main: 231129088 13:52:35 INFO - PROCESS | 32646 | 13:52:38 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:38 INFO - PROCESS | 32646 | RSS: Main: 225382400 13:52:38 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | Cycle 1(1): loaded http://localhost:50959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50959/tests/kraken/driver.html?testName=ai-astar) 13:52:40 INFO - PROCESS | 32646 | RSS: Main: 267767808 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | __start_tp_report 13:52:40 INFO - PROCESS | 32646 | _x_x_mozilla_page_load 13:52:40 INFO - PROCESS | 32646 | _x_x_mozilla_page_load_details 13:52:40 INFO - PROCESS | 32646 | |i|pagename|runs| 13:52:40 INFO - PROCESS | 32646 | |0;ai-astar;104;115;114;114;115;114;113;114;114;113 13:52:40 INFO - PROCESS | 32646 | |1;audio-beat-detection;154;122;123;199;127;123;157;127;169;125 13:52:40 INFO - PROCESS | 32646 | |2;audio-dft;161;161;161;161;163;162;162;160;163;167 13:52:40 INFO - PROCESS | 32646 | |3;audio-fft;75;76;76;126;78;78;75;76;107;76 13:52:40 INFO - PROCESS | 32646 | |4;audio-oscillator;85;87;119;85;86;85;114;85;85;132 13:52:40 INFO - PROCESS | 32646 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:52:40 INFO - PROCESS | 32646 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;146;147 13:52:40 INFO - PROCESS | 32646 | |7;imaging-desaturate;94;94;94;95;94;95;95;95;95;95 13:52:40 INFO - PROCESS | 32646 | |8;json-parse-financial;64;62;64;63;62;63;62;63;63;63 13:52:40 INFO - PROCESS | 32646 | |9;json-stringify-tinderbox;65;65;65;64;65;64;64;66;65;65 13:52:40 INFO - PROCESS | 32646 | |10;stanford-crypto-aes;82;78;79;79;80;82;79;78;79;83 13:52:40 INFO - PROCESS | 32646 | |11;stanford-crypto-ccm;137;125;128;138;137;126;130;132;174;131 13:52:40 INFO - PROCESS | 32646 | |12;stanford-crypto-pbkdf2;170;170;175;169;175;168;164;168;171;165 13:52:40 INFO - PROCESS | 32646 | |13;stanford-crypto-sha256-iterative;66;75;66;66;66;66;67;67;66;66 13:52:40 INFO - PROCESS | 32646 | __end_tp_report 13:52:40 INFO - PROCESS | 32646 | __start_cc_report 13:52:40 INFO - PROCESS | 32646 | _x_x_mozilla_cycle_collect,1921 13:52:40 INFO - PROCESS | 32646 | __end_cc_report 13:52:40 INFO - PROCESS | 32646 | __startTimestamp1468356760643__endTimestamp 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | ------- Summary: start ------- 13:52:40 INFO - PROCESS | 32646 | Number of tests: 14 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.23 (2.8%) stddev-sans-first:0.71 13:52:40 INFO - PROCESS | 32646 | Values: 104.0 115.0 114.0 114.0 115.0 114.0 113.0 114.0 114.0 113.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:140.50 stddev:26.26 (18.7%) stddev-sans-first:27.52 13:52:40 INFO - PROCESS | 32646 | Values: 154.0 122.0 123.0 199.0 127.0 123.0 157.0 127.0 169.0 125.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.97 (1.2%) stddev-sans-first:2.05 13:52:40 INFO - PROCESS | 32646 | Values: 161.0 161.0 161.0 161.0 163.0 162.0 162.0 160.0 163.0 167.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:17.58 (23.1%) stddev-sans-first:18.32 13:52:40 INFO - PROCESS | 32646 | Values: 75.0 76.0 76.0 126.0 78.0 78.0 75.0 76.0 107.0 76.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.06 (21.2%) stddev-sans-first:18.68 13:52:40 INFO - PROCESS | 32646 | Values: 85.0 87.0 119.0 85.0 86.0 85.0 114.0 85.0 85.0 132.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:52:40 INFO - PROCESS | 32646 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:52:40 INFO - PROCESS | 32646 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:52:40 INFO - PROCESS | 32646 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 13:52:40 INFO - PROCESS | 32646 | Values: 64.0 62.0 64.0 63.0 62.0 63.0 62.0 63.0 63.0 63.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:52:40 INFO - PROCESS | 32646 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 64.0 66.0 65.0 65.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:1.79 (2.3%) stddev-sans-first:1.73 13:52:40 INFO - PROCESS | 32646 | Values: 82.0 78.0 79.0 79.0 80.0 82.0 79.0 78.0 79.0 83.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:134.50 stddev:14.19 (10.5%) stddev-sans-first:15.04 13:52:40 INFO - PROCESS | 32646 | Values: 137.0 125.0 128.0 138.0 137.0 126.0 130.0 132.0 174.0 131.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:3.63 (2.1%) stddev-sans-first:3.84 13:52:40 INFO - PROCESS | 32646 | Values: 170.0 170.0 175.0 169.0 175.0 168.0 164.0 168.0 171.0 165.0 13:52:40 INFO - PROCESS | 32646 | 13:52:40 INFO - PROCESS | 32646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.00 stddev:2.81 (4.3%) stddev-sans-first:2.95 13:52:40 INFO - PROCESS | 32646 | Values: 66.0 75.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 66.0 13:52:40 INFO - PROCESS | 32646 | -------- Summary: end -------- 13:52:40 INFO - PROCESS | 32646 | 13:52:41 INFO - TEST-INFO | 32646: exit 0 13:52:41 INFO - TEST-OK | kraken | took 63285ms 13:52:41 INFO - SUITE-END | took 1183s 13:52:41 INFO - Completed test suite (00:19:43) 13:52:41 INFO - javascript benchmark 13:52:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.751693589109, 2613.8823752931116, 2639.722829102944, 2658.029819116022, 2658.9895839580945, 4656.79044443, 4657.930131048032, 4668.6731928765, 4688.32019357193, 4734.981978874542, 4708.882277943053, 4713.5993440557595, 4784.306275590037, 4797.208460603996, 4813.302071199682, 4098.631123198911, 4274.187904298189, 4362.149380870732, 4384.013596940695, 4497.370368148462, 4412.867613971586, 4451.132029254297, 4469.0614970855995, 4471.239889218824, 4501.5273396293405, 4266.3813747006825, 4272.807723652443, 4320.481542214923, 4324.654027677778, 4369.825206991716, 4262.701610887239, 4271.63691086258, 4321.481422229353, 4331.198728235287, 4331.696781225315, 4300.8709738707885, 4337.132573485315, 4351.5648435156545, 4362.236608593484, 4374.956250437519, 4520.751358675271, 4652.534746525354, 4762.499937506546, 4794.137055330039, 4794.5205479452125, 5112.0, 5113.846584602468, 5124.692518448905, 5132.820351287724, 5144.125498665236, 4991.450940396553, 5133.6149788765615, 5168.8449346519665, 5169.172932330846, 5169.56058735008, 4678.087772884289, 4730.2668086445965, 4731.550502702238, 4757.26262429324, 4796.400449943757, 5207.531322181022, 5218.478152184827, 5243.68537887728, 5245.186996015624, 5245.239440281138, 4887.218045112765, 4962.5533701967, 4974.37820272466, 4991.625628077909, 5001.149804533238, 5017.172166592544, 5067.543921047123, 5093.617978651542, 5139.0, 5140.151874940668, 5050.267711181858, 5065.974670126626, 5069.822556210515, 5072.087024335581, 5122.385313762298, 4889.853304400874, 4921.9507804922205, 4993.325901003391, 5027.572656324253, 5035.571976382049, 4275.337322714984, 4288.957110428856, 4322.502912165079, 4329.653627709776, 4332.501762297376, 3740.270647223765, 3758.530183727034, 3763.34141525232, 3801.961980380216, 3813.9618603813606, 4322.805473753689, 4363.410939523187, 4364.039911219526, 4395.142947125344, 4403.911921761611, 5096.9490305097215, 5109.335786347751, 5127.717975511308, 5133.383993920754, 5178.171492561172, 4420.513743488214, 4427.468703755506, 4432.3794668746405, 4477.104579084131, 4480.977595112004, 4436.0462500562535, 4477.686561940633, 4477.753723545171, 4592.471865735483, 4601.332806743004, 4720.362751028636, 4771.498992605726, 4783.6651434399255, 4787.712737235777, 4827.275908613736, 5054.393472783289, 5098.286239926488, 5101.540861322499, 5102.387713474407, 5133.974330128325, 4692.0, 4715.434147902273, 4739.526047395233, 4790.904181916412, 4854.19905715553, 4994.675346102492, 5000.599952003904, 5010.073136469765, 5025.7989680412375, 5026.59787217029, 5016.949830501649, 5083.110455670169, 5086.21163719624, 5157.7679004444135, 5160.922586161136, 4963.975180124221, 4971.229459433794, 4974.751262436791, 4977.477364876636, 5020.246962955586, 4954.851354459372, 4965.677230979974, 4966.106100901728, 4967.304577359245, 5003.974980125076, 4749.311349854321, 4788.904221915473, 4843.685160464559, 4849.418069831501, 4917.926231106465, 4974.900501989868, 4977.9751101244265, 4980.028894365564, 4985.252212168204, 4993.076280888047, 4710.882227944328, 4813.831515897067, 4862.07620552094, 4872.293517439881, 4877.829275975324], "value": 4657.159710401361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3764562959929, 562.7439515020664, 573.9725890655726, 581.0499832773415, 597.1281928384558, 26509.33726656832, 40855.0, 41801.16397672045, 41897.16205675885, 41951.0, 42151.78924105375, 42659.573404265946, 42760.0, 42767.78616106923, 42773.786131069304, 7763.728269510569, 7856.4893281936775, 7985.600719964008, 10116.14012808912, 10408.583656653725, 10277.897221027806, 10383.532741026673, 10390.116840068604, 10393.896061039368, 10394.480275986209, 10432.165426765841, 10482.737931551734, 10490.737731556696, 10491.37051776892, 10492.317999330056, 7646.732364367221, 10073.44596047217, 10303.072723454925, 10330.845037324447, 10667.199960002954, 10180.287379883412, 10233.130183934374, 10234.79530409395, 10242.385456872536, 10255.384676919333, 30562.235944101354, 40428.59571404278, 40730.57442989511, 40784.0, 40877.59122408797, 2808.592754050672, 2838.758705510034, 2918.2996080940634, 2923.283795470102, 3071.0633256856872, 29372.11883643494, 29647.258818529495, 30649.690883289863, 31002.0, 31784.205394865083, 3518.7888726676483, 3523.788572685647, 3600.6399360064047, 3614.150674591469, 3671.4492826076034, 268732.0, 274759.0, 274950.0, 276294.6185269081, 276593.0, 48204.27693584599, 56076.43923560712, 57685.134722979186, 57766.0, 63846.36153638497, 61172.38827611667, 61184.38815611876, 61410.69294653498, 61469.0, 61592.0, 12609.180403273758, 13446.865531344562, 13506.324683765772, 13522.729545409233, 13538.932305338607, 10645.148388128931, 10972.341659500455, 10979.1765617579, 12241.449134788778, 12260.938695306466, 19336.226550938085, 19370.5157371064, 19395.3211637592, 19407.611847762964, 19415.514612134528, 7077.9646101770195, 7113.181984071794, 7174.3184397482155, 7274.527155734861, 7431.479796414199, 781.2773184804033, 889.2752406788446, 935.5649622925372, 958.4153666263574, 962.4369743699874, 29103.56344654832, 29294.414111717648, 29385.0, 29620.703792962224, 30035.399292014037, 1011.5903059261011, 1024.4928760263567, 1047.9939258312106, 1057.534684738728, 1079.3038490173794, 15036.0, 15122.017068890487, 15475.767863482057, 15613.0449982521, 15635.3745850167, 439831.0, 443417.0, 443839.0, 444034.0, 448097.0, 51247.231291530654, 51912.48087519152, 51982.0, 52007.0, 52070.0, 1054.6466933577185, 1117.8211486162013, 1180.6576092933296, 1200.8318835363057, 1212.9393530323448, 27042.864785675945, 29220.853895730386, 29874.402511950073, 30325.39349212959, 30464.84767576148, 42810.0, 43143.56856431521, 43331.0, 43343.56656433395, 43372.34941475817, 304211.0, 305689.0, 305781.0, 305832.0, 306500.0, 25529.87235063813, 26864.194074177805, 26871.193864184104, 27925.44149117047, 38765.41851872281, 39638.405423918084, 39805.601943981346, 40346.79826600848, 40600.79699601483, 41187.0, 34466.82766586151, 34867.47698784571, 35225.29549409049, 35529.28941421105, 35745.463818043274, 35079.649203508656, 35566.466503002994, 35613.64386356103, 35771.28457430889, 35782.4632630516, 34736.82631586826, 34843.0, 34939.82530087333, 35508.82245588755, 35712.10719732028, 31263.218419538785, 31405.476658293697, 31888.36223275568, 31977.840110799298, 32127.83936080398, 24464.388390289674, 24745.25764227076, 24760.754204585934, 25009.0, 25011.749882500942], "value": 18492.33045616492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.58063742871127, 372.3929994109601, 372.9850805967761, 374.5449279125862, 380.43885269227894, 12873.420696068675, 16424.91787541062, 16792.74810877835, 16969.575760605992, 17950.64098718025, 16607.50177494677, 17050.658986820286, 17245.051522166308, 17313.30746770131, 17571.29714811406, 4545.181867263891, 5124.9487505124935, 5350.5184533391985, 5358.812441564546, 5361.356637203541, 5257.36911570612, 5313.0, 5314.9468505314835, 5323.41442441333, 5324.494173053554, 5153.123968925273, 5180.222966555009, 5228.869278268055, 5230.973845130769, 5240.973795131019, 5157.922631160535, 5211.973940130275, 5217.087009773274, 5218.660787048849, 5219.921701174486, 4418.977905110486, 4662.090892276007, 4664.253719404879, 4668.929966050512, 4673.976630116862, 20383.592328153354, 20691.27580534674, 21007.894960525253, 21120.577588448145, 21216.36350909475, 2049.1496029147884, 2282.9200977965693, 2347.7417484076736, 2401.951960960771, 2469.8888550015295, 12659.0, 13270.137441066396, 13308.201507909556, 13675.521356752566, 13741.312934353242, 1693.517347555953, 1745.5287072490357, 1783.678937791197, 1791.426743442099, 1803.8196180381988, 69488.0, 70581.64709176472, 72852.63573682151, 73003.63498182528, 73498.0, 8462.576871156418, 9097.1812536872, 9416.293777966679, 9558.665446709332, 9646.614135434504, 12006.87993120075, 12788.424520896582, 12881.291528965809, 13360.06479546442, 13372.130811497222, 7129.536580122275, 7405.666744996488, 7506.512076714996, 7512.962435187898, 7552.0, 6872.278410766898, 6894.965525172342, 7057.223705392403, 7118.857622847514, 7226.421886249087, 5770.365259821417, 6007.579469437185, 6053.364396738367, 6165.568410211242, 6198.6280823150755, 1708.3593652380357, 1718.4500959693028, 1727.6631056943775, 1776.9200385982663, 1827.1047186878334, 862.6247582301719, 876.9517676527852, 906.6282824042111, 991.1377101921374, 1012.7366884610054, 16582.58543536397, 17310.567235818955, 17471.475855724348, 17559.20983555743, 17789.644207115784, 860.2730692564772, 870.6778491957889, 874.4097734029505, 934.63082082577, 947.6825263536655, 9660.0, 9749.756256093513, 9775.169110625677, 9911.0, 9924.40453572788, 352285.3400261957, 373700.0, 374020.0, 377020.0, 377887.0, 72218.0, 72548.63725681338, 72910.0, 73035.0, 74399.62800185964, 887.5917078143997, 890.7728529225006, 896.4397251717677, 910.5947853205392, 936.7658085478494, 11877.249100359924, 15844.584323869118, 16058.437954671997, 16364.181790910645, 16576.917115414344, 37908.241835163695, 37909.62090379061, 37982.0, 38479.0, 38552.22895542017, 45978.0, 47504.52495475001, 47527.52472475231, 47763.0, 47912.28131578099, 7624.69501219945, 7643.503172293783, 7666.350258675797, 7694.461387702807, 7867.9606601966625, 10892.736676411254, 11619.883801161881, 11635.0, 11962.401879905796, 12112.45493952792, 10023.498825058863, 10125.0, 10417.270791044553, 10608.734781630521, 10754.085902698358, 10011.149052330633, 10039.849402259119, 10064.597416103274, 10198.33710808795, 10447.94776026115, 10242.129418999171, 10332.586696532355, 10712.464376780974, 10798.622048228275, 11021.944890275498, 7726.961365193138, 7747.147813740597, 7777.144514103331, 7835.098963619257, 7934.404919631166, 9649.951750241204, 10420.531076101744, 10479.371237725762, 10748.946255268673, 10909.563617455213], "value": 8346.406733062755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.9595612131639, 1364.3587513868483, 1452.2158034661284, 1655.710250706126, 1674.5227610131114, 7177.174624918136, 7492.100947886248, 7624.046994125734, 7624.085109786826, 7628.771136865896, 6348.968255158729, 7039.7536086237, 7281.453890958172, 7289.854202915939, 7500.39996800256, 2173.0981642618294, 2202.152171414009, 2203.8787866667326, 2204.206485665159, 2207.426069222006, 1883.1808163448875, 2223.6998005269324, 2230.565039817236, 2258.503129311549, 2259.2318611672026, 2120.0, 2202.8898555072265, 2213.8118259947923, 2229.0972156276734, 2233.575620632075, 2150.064721846002, 2158.1151727791607, 2163.5240247145603, 2165.4802847316687, 2224.922127725522, 2165.935021949344, 2214.1586197245106, 2218.0129842220217, 2218.0794970087395, 2218.7781221877844, 7539.170691223961, 7576.356009739179, 7578.621068946586, 7579.734709285149, 7581.507202031906, 4363.280058790296, 4466.0, 4473.083017981338, 4478.328250762379, 4484.708493947883, 2791.288221503524, 2824.915252542427, 2918.3433727411375, 2931.120663800851, 2931.399063192062, 883.2139395937621, 909.5406819556082, 917.289100946765, 918.3755046568331, 919.7286800393833, 9491.19324857388, 9506.096920792583, 9516.904830951671, 9517.762055948588, 9520.761980950463, 3961.187956468917, 4044.9797751011056, 4149.875503734893, 4210.073783767628, 4219.831206751695, 8251.628676709563, 8315.417920745489, 8319.500829950222, 8320.750377488685, 8325.542095184823, 4454.510003899569, 4461.152381047591, 4464.419625448671, 4465.843695470643, 4469.128519938581, 4013.7993100344866, 4069.2471892699946, 4073.3889916512167, 4075.3683179107284, 4078.1232035112594, 3585.4263317869536, 3620.637936206411, 3641.6358364163902, 3673.8163091845836, 3682.2819550187455, 1026.4918865161792, 1181.9113566482376, 1196.904247660185, 1199.9520019199308, 1210.2919791921825, 612.7855250662233, 750.2272659161073, 820.8029724224114, 820.9630566624517, 829.5520418973807, 4812.283121163425, 5071.137906555894, 5092.414372347153, 5115.283860259567, 5140.280360749498, 818.7830224990382, 867.800405906645, 876.2157868707471, 877.972771856929, 897.2194191053825, 3403.2002479417315, 3451.4132597458492, 3460.532828068229, 3467.7052450541987, 3503.474478828196, 8709.912900871037, 9336.813263734688, 9351.251899847995, 9358.298127640453, 9366.157045865904, 9061.59222834974, 9183.90816091844, 9196.12636799503, 9197.724068277963, 9233.90766092344, 6661.2006559213205, 6981.476389270825, 6995.685194166274, 7125.859862421988, 7133.322334378226, 4936.75316234194, 4950.45544990058, 5008.248762685626, 5052.72210028452, 5069.391672999263, 8309.418340716093, 8351.791205219675, 8588.398812083095, 8599.484030958163, 8605.483670979762, 8485.787855303666, 8638.26574741154, 8670.046294907681, 8788.42875213109, 8795.032546419761, 6503.837404064936, 6577.835554111186, 6605.867882642417, 6611.504137189826, 6645.568038077509, 7065.22282548909, 7178.4257259420165, 7248.0, 7255.09311336083, 7255.2019277880445, 4879.463259041431, 6577.210734711865, 6609.405153536205, 6733.0573719678305, 6815.182178138655, 6495.707693153914, 6544.345565443417, 6548.705308261045, 6570.507211959027, 6592.901106483502, 5494.0, 5748.080307150836, 5757.798477053283, 5844.707764611668, 5844.883102337844, 4248.830046798217, 4266.06146647737, 4285.657147428261, 4344.8044837983, 4377.6497880170145, 4322.546132656152, 4420.403245561808, 4451.065276292015, 4479.238529449936, 4538.591526762607], "value": 4002.782874950634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.1193639241295, 299.3085971406052, 299.94451026560085, 301.9199912023313, 305.68209062574925, 4909.0, 4921.8523444296725, 4927.556519913207, 4935.087008903355, 4962.602991760659, 4805.447373552042, 4814.807407703687, 4841.419029716439, 4849.781759820808, 4853.830115945942, 3607.1883826139106, 3741.6904083570803, 3750.0, 3851.73037887348, 3855.595162507924, 3843.730938834283, 3844.4809950656722, 3848.615138486157, 3860.498135242429, 3876.592957739439, 3633.273345330931, 3761.3417651910945, 3795.601461846508, 3831.157145428015, 3841.673457756094, 3748.418995055757, 3817.618238176188, 3837.021559502309, 3855.7108216883566, 3861.4787003754413, 3390.6609339066144, 3398.7764404814247, 3398.7790793598583, 3416.8462419191196, 3424.5376874121926, 4771.832985845514, 4784.727254554094, 4788.138135135674, 4796.304535842318, 4803.78382972767, 4242.172776308621, 4413.249747542894, 4413.9254550361275, 4417.917610185493, 4425.845095421645, 5029.748512574393, 5081.517255860687, 5092.0, 5098.444974282842, 5107.438181799999, 3744.2511497700298, 3745.700343972476, 3753.6997040236715, 3757.248550289953, 3760.304343696425, 5201.24581935621, 5287.68273903567, 5340.572754179656, 5371.167469042305, 5371.355437347544, 3797.9810100949317, 3800.7909564974193, 3803.505544279226, 3813.5614404343855, 3815.6756675682877, 3867.8646247381207, 3873.3802591585213, 3874.8256328465286, 3887.5723670396233, 3889.183271512957, 4375.606195442426, 4398.494173170063, 4400.185965596375, 4404.11917616478, 4417.712848664826, 4882.707037577757, 5078.898422031539, 5080.59355251579, 5086.2960908095465, 5127.589792816566, 1280.3982128399637, 1304.4390911907972, 1305.9804102938463, 1307.6730817295677, 1311.2460335307237, 835.1940377535707, 841.1840514700731, 866.4757821517891, 897.717219075989, 897.9673375618091, 4469.888252793706, 4492.752898590609, 4501.347304640809, 4507.143642707941, 4514.593686568224, 5160.767765450564, 5200.947990520122, 5202.08963431398, 5240.187770895517, 5254.632175747661, 4351.82592696295, 4488.236999710057, 4503.392042074278, 4520.841770538015, 4572.0, 2793.483205606969, 2819.732125448079, 2827.787915906274, 2832.589274555178, 2834.67401248859, 5005.27423523587, 5018.272350509155, 5028.723420211851, 5030.89938201234, 5033.295338652591, 5164.896702066013, 5435.239066530688, 5458.918116228259, 5482.698451585201, 5524.447555244524, 5014.690304399079, 5014.974925125351, 5024.221245706921, 5027.472115427828, 5033.144365457881, 5312.495312945264, 5324.6006549508165, 5327.9467205329, 5354.437784032621, 5392.325959255093, 5093.770780314969, 5101.285819985131, 5161.612879034013, 5167.948320516747, 5181.0, 4936.901261974812, 4966.453690094159, 4972.825951091694, 4978.626603004862, 4978.925316120189, 3782.829772660182, 3787.4129509926006, 3795.9430608540342, 3814.942775858309, 3818.16000479894, 5129.692218466904, 5289.7355132244, 5324.840254792362, 5335.813246536508, 5372.489613486712, 5102.66832655891, 5108.66793658411, 5119.385673719177, 5134.820281290137, 5138.897222055463, 5125.2568377585785, 5126.564242039469, 5134.512221338967, 5150.1502252127975, 5161.638685291993, 4822.987172693774, 4934.481879402611, 5047.848564543069, 5069.504496173711, 5080.339555857715, 5003.249512572997, 5133.922991155061, 5166.0, 5189.532942035235, 5196.298499702491, 5043.218301163325, 5050.469700681522, 5099.056674515226, 5107.79568817258, 5118.6947328431015], "value": 3877.0171835218507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.3778634724317, 649.4804156674661, 672.9562578432405, 698.4691634357887, 734.3317581001284, 12962.675933101676, 13472.865271347284, 13584.592462226125, 13622.659433514167, 13639.659008524779, 13678.52125175619, 14331.0, 14397.352119154637, 14874.405023799036, 14901.956863019594, 783.9490433121844, 801.3789313282194, 801.4029547986758, 804.6178065418909, 804.9114597394282, 624.2134910013393, 763.5151678684048, 794.4041968523608, 794.5788731972063, 796.410656114474, 828.958552072397, 834.4450940124809, 835.0980940584185, 835.5655059369154, 837.530982649715, 647.7085311609748, 828.3125006244802, 828.5111784047441, 828.6892415344277, 829.0672992883007, 589.4606435111867, 610.188449362347, 610.4658423879106, 610.6580315023557, 613.2150846915955, 13520.661983450394, 13606.251656158907, 13614.727705445835, 13617.387217575233, 13630.1140425872, 12226.449809758582, 12742.872571274262, 12823.74352512954, 12868.871311286954, 13002.414891329912, 11741.952894259462, 12121.27272363661, 12253.938730306381, 12467.314297713621, 12870.67823304425, 4096.221717873595, 4105.712600117993, 4122.093139509303, 4242.342436922282, 4275.786210689453, 62031.379686203014, 62372.0, 62656.0, 62838.0, 64324.678376607815, 10087.798244035079, 10340.172786177087, 10350.844737328945, 10364.844527332096, 10374.0, 17894.5526361842, 19108.713369299472, 19124.33064842724, 19134.23463061462, 19169.904150479437, 6523.804285871432, 6657.633830139389, 6696.8995465068065, 7024.332688394697, 7110.360067593838, 3722.4602432647116, 3785.37541305687, 3810.866619668354, 3868.574456809749, 3873.070463088895, 2664.3472349274552, 2755.2698534888273, 2784.721527847199, 2785.1644506647926, 2785.582162675574, 511.3250509327652, 513.5891286970409, 523.0924346259237, 527.9076161671692, 529.9205119232068, 572.9914051289234, 592.1739173852452, 595.5057302438966, 597.4831770518471, 613.1385403508078, 8253.422260441712, 8341.582920853933, 8546.188112129337, 8640.611172497252, 8703.869441958375, 548.9396166421691, 592.6918002638604, 604.3412680178538, 611.078159189347, 623.1774058243076, 4240.893977650583, 4269.807858646368, 4363.236433624166, 4419.403380543586, 4513.774311284488, 90347.54826225826, 92272.07727922768, 94099.0, 94510.52744736233, 94707.52646236862, 83343.0, 83388.58305708555, 83703.58148209342, 83763.32473350498, 84309.57845210857, 44456.55543444589, 66760.0, 70433.6478317605, 72743.0, 73596.63201683958, 8304.6678132874, 9096.636134554808, 9141.817163656557, 9214.631414743335, 9488.193503552275, 34533.65466345405, 42679.0, 43179.78410107929, 44154.0, 46181.76909115433, 44772.77613611911, 65056.0, 65268.67365663331, 65315.34684653093, 67056.66471667611, 11265.831012534654, 11469.655910322703, 11540.422978850856, 11944.104192185447, 12083.818742718691, 13417.194968301934, 13597.79603305971, 13651.522196723066, 13911.652208694864, 14461.85538144605, 11955.103367247317, 12084.92430207841, 12452.08815778971, 12894.871051289367, 13268.0, 12813.295268760308, 13036.804447933479, 13280.601581952556, 13370.598882033555, 13717.862821372059, 12057.216280941711, 12084.637460876187, 12371.195872268274, 12717.236965782082, 12847.743045139232, 9387.577559009998, 9421.340506164777, 9527.666531671359, 9698.85451718239, 10273.897261027294, 9912.15746661542, 10350.964903509588, 10469.9476502617, 10498.895011049792, 10588.841167382341], "value": 6740.9524493766885, "unit": "score"}], "name": "dromaeo_css", "value": 6496.922122302262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 123.0, 199.0, 127.0, 123.0, 157.0, 127.0, 169.0, 125.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 160.0, 163.0, 167.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 126.0, 78.0, 78.0, 75.0, 76.0, 107.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 119.0, 85.0, 86.0, 85.0, 114.0, 85.0, 85.0, 132.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 79.0, 79.0, 80.0, 82.0, 79.0, 78.0, 79.0, 83.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 125.0, 128.0, 138.0, 137.0, 126.0, 130.0, 132.0, 174.0, 131.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 175.0, 169.0, 175.0, 168.0, 164.0, 168.0, 171.0, 165.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1536.1999999999998, "alertThreshold": 2.0}]} 13:52:41 INFO - Return code: 0 13:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:52:41 INFO - # TBPL SUCCESS # 13:52:41 INFO - Running post-action listener: _resource_record_post_action 13:52:41 INFO - ##### 13:52:41 INFO - ##### Finished run-tests step (success) 13:52:41 INFO - ##### 13:52:41 INFO - Running post-run listener: _resource_record_post_run 13:52:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534462464; Read time: 8; Write time: 454428 13:52:42 INFO - TinderboxPrint: CPU usage
13.0% 13:52:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:52:42 INFO - TinderboxPrint: I/O write bytes / time
534,462,464 / 454,428 13:52:42 INFO - TinderboxPrint: CPU idle
8,335.9 (87.0%) 13:52:42 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 13:52:42 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246644736; Read time: 0; Write time: 271900 13:52:42 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287817728; Read time: 0; Write time: 182528 13:52:42 INFO - Running post-run listener: _upload_blobber_files 13:52:42 INFO - Blob upload gear active. 13:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:42 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 13:52:42 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:52:42 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:52:42 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:43 INFO - (blobuploader) - INFO - Done attempting. 13:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:47 INFO - (blobuploader) - INFO - Done attempting. 13:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:48 INFO - (blobuploader) - INFO - Done attempting. 13:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:48 INFO - Return code: 0 13:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26bcd6f93fdc57a8835702c3ead190537005a4f69797e86f01693e32cbf0ed79b45f36ab544b3f5aab90dc60c7a0c3a4de00c0839738ce5ac9c3172e1c4e3e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cbb6b89c6de40fe1a68ece915e88bb34dc3139be7292d28dbd96aa06817f85ebfafe8e8f7e509722dc0e5689bd0dd80c0f1529a3e04275fb242ae4a35b2203", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb70dede68ea0419c04d41bbef438e08fefc01f029628366dffe927e92f6d008a3eb2b68f4721fcae75223b939eb73833da01df8171ff4af1ecec7264c5f8102"} 13:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:48 INFO - Contents: 13:52:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26bcd6f93fdc57a8835702c3ead190537005a4f69797e86f01693e32cbf0ed79b45f36ab544b3f5aab90dc60c7a0c3a4de00c0839738ce5ac9c3172e1c4e3e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cbb6b89c6de40fe1a68ece915e88bb34dc3139be7292d28dbd96aa06817f85ebfafe8e8f7e509722dc0e5689bd0dd80c0f1529a3e04275fb242ae4a35b2203", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb70dede68ea0419c04d41bbef438e08fefc01f029628366dffe927e92f6d008a3eb2b68f4721fcae75223b939eb73833da01df8171ff4af1ecec7264c5f8102"} 13:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:48 INFO - Copying logs to upload dir... 13:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.327777 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-12 13:52:48.117257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 13:52:48.120562) ========= 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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26bcd6f93fdc57a8835702c3ead190537005a4f69797e86f01693e32cbf0ed79b45f36ab544b3f5aab90dc60c7a0c3a4de00c0839738ce5ac9c3172e1c4e3e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cbb6b89c6de40fe1a68ece915e88bb34dc3139be7292d28dbd96aa06817f85ebfafe8e8f7e509722dc0e5689bd0dd80c0f1529a3e04275fb242ae4a35b2203", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb70dede68ea0419c04d41bbef438e08fefc01f029628366dffe927e92f6d008a3eb2b68f4721fcae75223b939eb73833da01df8171ff4af1ecec7264c5f8102"} build_url:https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/HO5CFHiyR7e_z2rHda0vfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26bcd6f93fdc57a8835702c3ead190537005a4f69797e86f01693e32cbf0ed79b45f36ab544b3f5aab90dc60c7a0c3a4de00c0839738ce5ac9c3172e1c4e3e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cbb6b89c6de40fe1a68ece915e88bb34dc3139be7292d28dbd96aa06817f85ebfafe8e8f7e509722dc0e5689bd0dd80c0f1529a3e04275fb242ae4a35b2203", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb70dede68ea0419c04d41bbef438e08fefc01f029628366dffe927e92f6d008a3eb2b68f4721fcae75223b939eb73833da01df8171ff4af1ecec7264c5f8102"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 13:52:48.146252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:52:48.146586) ========= 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=232498196343f89f466a4a9a000001c8-1468355358.971465-12512703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:52:48.231134) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 13:52:48.231463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 13:52:48.231771) ========= ========= Total master_lag: 0.16 =========