builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1468447514.98 results: success (0) buildid: 20160713141243 builduid: f3951c46a3fb48cab5dd879fd58ef295 revision: 0ec4b1228536dabe17e78060f4413fc91b162d58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:14.976059) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:14.976540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:14.976871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:14.991299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:14.991583) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 15:05:15-- 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% 37.7M=0s 2016-07-13 15:05:15 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069978 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:15.075533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:15.075894) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:15.125633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:05:15.126002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ec4b1228536dabe17e78060f4413fc91b162d58 --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 0ec4b1228536dabe17e78060f4413fc91b162d58 --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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 15:05:15,394 truncating revision to first 12 chars 2016-07-13 15:05:15,394 Setting DEBUG logging. 2016-07-13 15:05:15,394 attempt 1/10 2016-07-13 15:05:15,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ec4b1228536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 15:05:16,291 unpacking tar archive at: fx-team-0ec4b1228536/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:05:16.399030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:16.399358) ========= script_repo_revision: 0ec4b1228536dabe17e78060f4413fc91b162d58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:16.399783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:16.400054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:05:16.410175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-13 15:05:16.410578) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:16 INFO - MultiFileLogger online at 20160713 15:05:16 in /builds/slave/test 15:05:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:05:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:16 INFO - {'append_to_log': False, 15:05:16 INFO - 'base_work_dir': '/builds/slave/test', 15:05:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:16 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:16 INFO - 'config_files': ('talos/linux_config.py',), 15:05:16 INFO - 'default_actions': ('clobber', 15:05:16 INFO - 'read-buildbot-config', 15:05:16 INFO - 'download-and-extract', 15:05:16 INFO - 'populate-webroot', 15:05:16 INFO - 'create-virtualenv', 15:05:16 INFO - 'install', 15:05:16 INFO - 'run-tests'), 15:05:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:16 INFO - 'download_minidump_stackwalk': True, 15:05:16 INFO - 'download_symbols': 'ondemand', 15:05:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:16 INFO - 'installer_path': 'installer.exe', 15:05:16 INFO - 'log_level': 'info', 15:05:16 INFO - 'log_name': 'talos', 15:05:16 INFO - 'log_to_console': True, 15:05:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:16 INFO - 'opt_config_files': (), 15:05:16 INFO - 'pip_index': False, 15:05:16 INFO - 'sps_profile': False, 15:05:16 INFO - 'sps_profile_interval': 0, 15:05:16 INFO - 'suite': 'dromaeojs-e10s', 15:05:16 INFO - 'system_bits': '32', 15:05:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:16 INFO - 'title': 'talos-linux64-ix-013', 15:05:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:16 INFO - 'use_talos_json': True, 15:05:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:16 INFO - 'work_dir': 'build'} 15:05:16 INFO - ##### 15:05:16 INFO - ##### Running clobber step. 15:05:16 INFO - ##### 15:05:16 INFO - Running pre-action listener: _resource_record_pre_action 15:05:16 INFO - Running main action method: clobber 15:05:16 INFO - rmtree: /builds/slave/test/build 15:05:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:17 INFO - Running post-action listener: _resource_record_post_action 15:05:17 INFO - ##### 15:05:17 INFO - ##### Finished clobber step (success) 15:05:17 INFO - ##### 15:05:17 INFO - ##### 15:05:17 INFO - ##### Running read-buildbot-config step. 15:05:17 INFO - ##### 15:05:17 INFO - Running pre-action listener: _resource_record_pre_action 15:05:17 INFO - Running main action method: read_buildbot_config 15:05:17 INFO - Using buildbot properties: 15:05:17 INFO - { 15:05:17 INFO - "project": "", 15:05:17 INFO - "product": "firefox", 15:05:17 INFO - "script_repo_revision": "production", 15:05:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:05:17 INFO - "repository": "", 15:05:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:05:17 INFO - "buildid": "20160713141243", 15:05:17 INFO - "pgo_build": "False", 15:05:17 INFO - "basedir": "/builds/slave/test", 15:05:17 INFO - "buildnumber": 1463, 15:05:17 INFO - "slavename": "talos-linux64-ix-013", 15:05:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:05:17 INFO - "platform": "ubuntu64_hw", 15:05:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:17 INFO - "branch": "fx-team", 15:05:17 INFO - "repo_path": "integration/fx-team", 15:05:17 INFO - "revision": "0ec4b1228536dabe17e78060f4413fc91b162d58", 15:05:17 INFO - "stage_platform": "linux64", 15:05:17 INFO - "builduid": "f3951c46a3fb48cab5dd879fd58ef295", 15:05:17 INFO - "slavebuilddir": "test" 15:05:17 INFO - } 15:05:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:05:17 INFO - Running post-action listener: _resource_record_post_action 15:05:17 INFO - ##### 15:05:17 INFO - ##### Finished read-buildbot-config step (success) 15:05:17 INFO - ##### 15:05:17 INFO - ##### 15:05:17 INFO - ##### Running download-and-extract step. 15:05:17 INFO - ##### 15:05:17 INFO - Running pre-action listener: _resource_record_pre_action 15:05:17 INFO - Running main action method: download_and_extract 15:05:17 INFO - mkdir: /builds/slave/test/build/tests 15:05: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')]} 15:05:17 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:18 INFO - Downloaded 1361 bytes. 15:05:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:18 INFO - Using the following test package requirements: 15:05:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'jsshell-linux-x86_64.zip'], 15:05:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05:18 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')]} 15:05:18 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:19 INFO - Downloaded 22755452 bytes. 15:05:19 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'] 15:05:19 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 15:05:20 INFO - Return code: 0 15:05:20 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 15:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:20 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:21 INFO - Downloaded 22755452 bytes. 15:05:21 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'] 15:05:21 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 15:05:23 INFO - Return code: 0 15:05:23 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')]} 15:05:23 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:24 INFO - Downloaded 14403317 bytes. 15:05:24 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'] 15:05:24 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 15:05:24 INFO - Return code: 0 15:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:24 INFO - https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5-Hs1eIRYubQUHtdTjAZA/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 15:05:25 INFO - Downloaded 57039899 bytes. 15:05:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:25 INFO - mkdir: /builds/slave/test/properties 15:05:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:25 INFO - Contents: 15:05:25 INFO - build_url:https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:26 INFO - Running post-action listener: _resource_record_post_action 15:05:26 INFO - Running post-action listener: set_extra_try_arguments 15:05:26 INFO - ##### 15:05:26 INFO - ##### Finished download-and-extract step (success) 15:05:26 INFO - ##### 15:05:26 INFO - ##### 15:05:26 INFO - ##### Running populate-webroot step. 15:05:26 INFO - ##### 15:05:26 INFO - Running pre-action listener: _resource_record_pre_action 15:05:26 INFO - Running main action method: populate_webroot 15:05:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:26 INFO - '--tppagecycles', 15:05:26 INFO - '7'], 15:05:26 INFO - 'tests': ['tsvgm']}}, 15:05:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['damp', 'tps']}, 15:05:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'tests': ['damp', 'tps']}, 15:05:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['dromaeo_dom']}, 15:05:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['basic_compositor_video']}, 15:05:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:05:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['a11yr', 15:05:26 INFO - 'ts_paint', 15:05:26 INFO - 'tpaint', 15:05:26 INFO - 'sessionrestore', 15:05:26 INFO - 'sessionrestore_no_auto_restore', 15:05:26 INFO - 'tabpaint']}, 15:05:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['tsvgx', 15:05:26 INFO - 'tsvgr_opacity', 15:05:26 INFO - 'tart', 15:05:26 INFO - 'tscrollx', 15:05:26 INFO - 'cart']}, 15:05:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:26 INFO - 'tsvgr_opacity', 15:05:26 INFO - 'tart', 15:05:26 INFO - 'tscrollx', 15:05:26 INFO - 'cart']}, 15:05:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'talos_options': ['--disable-e10s'], 15:05:26 INFO - 'tests': ['tp5o']}, 15:05:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'tests': ['tp5o']}, 15:05:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'talos_options': ['--disable-e10s', 15:05:26 INFO - '--xperf_path', 15:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:26 INFO - 'tests': ['tp5n']}, 15:05:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:26 INFO - 'talos_options': ['--xperf_path', 15:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:26 INFO - 'tests': ['tp5n']}}, 15:05:26 INFO - 'talos.zip': {'path': '', 15:05:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:26 INFO - Running post-action listener: _resource_record_post_action 15:05:26 INFO - ##### 15:05:26 INFO - ##### Finished populate-webroot step (success) 15:05:26 INFO - ##### 15:05:26 INFO - ##### 15:05:26 INFO - ##### Running create-virtualenv step. 15:05:26 INFO - ##### 15:05:26 INFO - Running pre-action listener: _resource_record_pre_action 15:05:26 INFO - Running main action method: create_virtualenv 15:05:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:26 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 15:05:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:26 INFO - Using real prefix '/usr' 15:05:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:29 INFO - Installing pip.................done. 15:05:29 INFO - Return code: 0 15:05:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:29 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:29 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 15:05:29 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 15:05:29 INFO - Using env: {'DISPLAY': ':0', 15:05:29 INFO - 'HOME': '/home/cltbld', 15:05:29 INFO - 'LANG': 'en_US.UTF-8', 15:05:29 INFO - 'LANGUAGE': 'en_US:en', 15:05:29 INFO - 'LOGNAME': 'cltbld', 15:05:29 INFO - 'MAIL': '/var/mail/cltbld', 15:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:29 INFO - 'MOZ_NO_REMOTE': '1', 15:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:29 INFO - 'NO_EM_RESTART': '1', 15:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:29 INFO - 'PWD': '/builds/slave/test', 15:05:29 INFO - 'SHELL': '/bin/bash', 15:05:29 INFO - 'SHLVL': '1', 15:05:29 INFO - 'TERM': 'linux', 15:05:29 INFO - 'TMOUT': '86400', 15:05:29 INFO - 'USER': 'cltbld', 15:05:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:29 INFO - '_': '/tools/buildbot/bin/python'} 15:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:29 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 15:05:29 INFO - Cleaning up... 15:05:29 INFO - Return code: 0 15:05:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:29 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:29 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 15:05:29 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 15:05:29 INFO - Using env: {'DISPLAY': ':0', 15:05:29 INFO - 'HOME': '/home/cltbld', 15:05:29 INFO - 'LANG': 'en_US.UTF-8', 15:05:29 INFO - 'LANGUAGE': 'en_US:en', 15:05:29 INFO - 'LOGNAME': 'cltbld', 15:05:29 INFO - 'MAIL': '/var/mail/cltbld', 15:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:29 INFO - 'MOZ_NO_REMOTE': '1', 15:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:29 INFO - 'NO_EM_RESTART': '1', 15:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:29 INFO - 'PWD': '/builds/slave/test', 15:05:29 INFO - 'SHELL': '/bin/bash', 15:05:29 INFO - 'SHLVL': '1', 15:05:29 INFO - 'TERM': 'linux', 15:05:29 INFO - 'TMOUT': '86400', 15:05:29 INFO - 'USER': 'cltbld', 15:05:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:29 INFO - '_': '/tools/buildbot/bin/python'} 15:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:29 INFO - Downloading/unpacking psutil>=3.1.1 15:05:29 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 15:05:29 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 15:05:29 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 15:05:29 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 15:05:29 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 15:05:29 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 15:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:31 INFO - Installing collected packages: psutil 15:05:31 INFO - Running setup.py install for psutil 15:05:31 INFO - building 'psutil._psutil_linux' extension 15:05:31 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 15:05:31 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 15:05:31 INFO - building 'psutil._psutil_posix' extension 15:05:31 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 15:05:31 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 15:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:31 INFO - Successfully installed psutil 15:05:31 INFO - Cleaning up... 15:05:32 INFO - Return code: 0 15:05:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:32 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:32 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 15:05:32 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 15:05:32 INFO - Using env: {'DISPLAY': ':0', 15:05:32 INFO - 'HOME': '/home/cltbld', 15:05:32 INFO - 'LANG': 'en_US.UTF-8', 15:05:32 INFO - 'LANGUAGE': 'en_US:en', 15:05:32 INFO - 'LOGNAME': 'cltbld', 15:05:32 INFO - 'MAIL': '/var/mail/cltbld', 15:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:32 INFO - 'MOZ_NO_REMOTE': '1', 15:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:32 INFO - 'NO_EM_RESTART': '1', 15:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:32 INFO - 'PWD': '/builds/slave/test', 15:05:32 INFO - 'SHELL': '/bin/bash', 15:05:32 INFO - 'SHLVL': '1', 15:05:32 INFO - 'TERM': 'linux', 15:05:32 INFO - 'TMOUT': '86400', 15:05:32 INFO - 'USER': 'cltbld', 15:05:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:32 INFO - '_': '/tools/buildbot/bin/python'} 15:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:34 INFO - Installing collected packages: mozsystemmonitor 15:05:34 INFO - Running setup.py install for mozsystemmonitor 15:05:34 INFO - Successfully installed mozsystemmonitor 15:05:34 INFO - Cleaning up... 15:05:34 INFO - Return code: 0 15:05:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:34 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 15:05:34 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 15:05:34 INFO - Using env: {'DISPLAY': ':0', 15:05:34 INFO - 'HOME': '/home/cltbld', 15:05:34 INFO - 'LANG': 'en_US.UTF-8', 15:05:34 INFO - 'LANGUAGE': 'en_US:en', 15:05:34 INFO - 'LOGNAME': 'cltbld', 15:05:34 INFO - 'MAIL': '/var/mail/cltbld', 15:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:34 INFO - 'MOZ_NO_REMOTE': '1', 15:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:34 INFO - 'NO_EM_RESTART': '1', 15:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:34 INFO - 'PWD': '/builds/slave/test', 15:05:34 INFO - 'SHELL': '/bin/bash', 15:05:34 INFO - 'SHLVL': '1', 15:05:34 INFO - 'TERM': 'linux', 15:05:34 INFO - 'TMOUT': '86400', 15:05:34 INFO - 'USER': 'cltbld', 15:05:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:34 INFO - '_': '/tools/buildbot/bin/python'} 15:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:36 INFO - warning: no files found matching '*.txt' 15:05:36 INFO - no previously-included directories found matching 'build' 15:05:36 INFO - no previously-included directories found matching 'dist' 15:05:36 INFO - no previously-included directories found matching '.git*' 15:05:36 INFO - Installing collected packages: jsonschema, functools32 15:05:36 INFO - Running setup.py install for functools32 15:05:36 INFO - warning: no files found matching '*.txt' 15:05:36 INFO - no previously-included directories found matching 'build' 15:05:36 INFO - no previously-included directories found matching 'dist' 15:05:36 INFO - no previously-included directories found matching '.git*' 15:05:36 INFO - Successfully installed jsonschema functools32 15:05:36 INFO - Cleaning up... 15:05:36 INFO - Return code: 0 15:05:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:36 INFO - Using env: {'DISPLAY': ':0', 15:05:36 INFO - 'HOME': '/home/cltbld', 15:05:36 INFO - 'LANG': 'en_US.UTF-8', 15:05:36 INFO - 'LANGUAGE': 'en_US:en', 15:05:36 INFO - 'LOGNAME': 'cltbld', 15:05:36 INFO - 'MAIL': '/var/mail/cltbld', 15:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:36 INFO - 'MOZ_NO_REMOTE': '1', 15:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:36 INFO - 'NO_EM_RESTART': '1', 15:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:36 INFO - 'PWD': '/builds/slave/test', 15:05:36 INFO - 'SHELL': '/bin/bash', 15:05:36 INFO - 'SHLVL': '1', 15:05:36 INFO - 'TERM': 'linux', 15:05:36 INFO - 'TMOUT': '86400', 15:05:36 INFO - 'USER': 'cltbld', 15:05:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:36 INFO - '_': '/tools/buildbot/bin/python'} 15:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:37 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 15:05:37 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 15:05:37 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 15:05:37 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 15:05:37 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 15:05:37 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 15:05:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 INFO - Downloading docopt-0.6.1.tar.gz 15:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:39 INFO - Running setup.py install for blobuploader 15:05:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:39 INFO - Running setup.py install for requests 15:05:40 INFO - Running setup.py install for docopt 15:05:40 INFO - Successfully installed blobuploader requests docopt 15:05:40 INFO - Cleaning up... 15:05:40 INFO - Return code: 0 15:05:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:40 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')]} 15:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:40 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')]} 15:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:40 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:40 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 15:05:40 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 15:05:40 INFO - Using env: {'DISPLAY': ':0', 15:05:40 INFO - 'HOME': '/home/cltbld', 15:05:40 INFO - 'LANG': 'en_US.UTF-8', 15:05:40 INFO - 'LANGUAGE': 'en_US:en', 15:05:40 INFO - 'LOGNAME': 'cltbld', 15:05:40 INFO - 'MAIL': '/var/mail/cltbld', 15:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:40 INFO - 'MOZ_NO_REMOTE': '1', 15:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:40 INFO - 'NO_EM_RESTART': '1', 15:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:40 INFO - 'PWD': '/builds/slave/test', 15:05:40 INFO - 'SHELL': '/bin/bash', 15:05:40 INFO - 'SHLVL': '1', 15:05:40 INFO - 'TERM': 'linux', 15:05:40 INFO - 'TMOUT': '86400', 15:05:40 INFO - 'USER': 'cltbld', 15:05:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:40 INFO - '_': '/tools/buildbot/bin/python'} 15:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:40 INFO - Running setup.py (path:/tmp/pip-kcgPsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:40 INFO - Running setup.py (path:/tmp/pip-qW2kPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:40 INFO - Running setup.py (path:/tmp/pip-CopMbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:40 INFO - Running setup.py (path:/tmp/pip-x_V6Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:40 INFO - Running setup.py (path:/tmp/pip-0sx7iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:41 INFO - Running setup.py (path:/tmp/pip-Ypg0Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:41 INFO - Running setup.py (path:/tmp/pip-NgWYGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:41 INFO - Running setup.py (path:/tmp/pip-3LyxTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:41 INFO - Running setup.py (path:/tmp/pip-8jb_1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:41 INFO - Running setup.py (path:/tmp/pip-PFyfmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:41 INFO - Running setup.py (path:/tmp/pip-Wy8LwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:41 INFO - Running setup.py (path:/tmp/pip-Pq77cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:41 INFO - Running setup.py (path:/tmp/pip-36VSnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:41 INFO - Running setup.py (path:/tmp/pip-qctDoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:41 INFO - Running setup.py (path:/tmp/pip-ap4EfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:41 INFO - Running setup.py (path:/tmp/pip-Yb_MeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:41 INFO - Running setup.py (path:/tmp/pip-9quKS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:41 INFO - Running setup.py install for manifestparser 15:05:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for mozcrash 15:05:42 INFO - Running setup.py install for mozdebug 15:05:42 INFO - Running setup.py install for mozdevice 15:05:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for mozfile 15:05:42 INFO - Running setup.py install for mozhttpd 15:05:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for mozinfo 15:05:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for mozInstall 15:05:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for mozleak 15:05:42 INFO - Running setup.py install for mozlog 15:05:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:42 INFO - Running setup.py install for moznetwork 15:05:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Running setup.py install for mozprocess 15:05:43 INFO - Running setup.py install for mozprofile 15:05:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Running setup.py install for mozrunner 15:05:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Running setup.py install for mozscreenshot 15:05:43 INFO - Running setup.py install for moztest 15:05:43 INFO - Running setup.py install for mozversion 15:05:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:43 INFO - Cleaning up... 15:05:43 INFO - Return code: 0 15:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:43 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:43 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 15:05:43 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 15:05:43 INFO - Using env: {'DISPLAY': ':0', 15:05:43 INFO - 'HOME': '/home/cltbld', 15:05:43 INFO - 'LANG': 'en_US.UTF-8', 15:05:43 INFO - 'LANGUAGE': 'en_US:en', 15:05:43 INFO - 'LOGNAME': 'cltbld', 15:05:43 INFO - 'MAIL': '/var/mail/cltbld', 15:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:43 INFO - 'MOZ_NO_REMOTE': '1', 15:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:43 INFO - 'NO_EM_RESTART': '1', 15:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:43 INFO - 'PWD': '/builds/slave/test', 15:05:43 INFO - 'SHELL': '/bin/bash', 15:05:43 INFO - 'SHLVL': '1', 15:05:43 INFO - 'TERM': 'linux', 15:05:43 INFO - 'TMOUT': '86400', 15:05:43 INFO - 'USER': 'cltbld', 15:05:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:43 INFO - '_': '/tools/buildbot/bin/python'} 15:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:43 INFO - Running setup.py (path:/tmp/pip-yW5lN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:43 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)) 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:43 INFO - Running setup.py (path:/tmp/pip-k_kWJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:44 INFO - Running setup.py (path:/tmp/pip-jVi9cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:44 INFO - Running setup.py (path:/tmp/pip-Px40CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:44 INFO - Running setup.py (path:/tmp/pip-xxGuMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:44 INFO - Running setup.py (path:/tmp/pip-IwY9sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:44 INFO - Running setup.py (path:/tmp/pip-UfUNEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:44 INFO - Running setup.py (path:/tmp/pip-J_yiF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:44 INFO - Running setup.py (path:/tmp/pip-VG7jtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:44 INFO - Running setup.py (path:/tmp/pip-Ga0end-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:44 INFO - Running setup.py (path:/tmp/pip-W7sLum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:44 INFO - Running setup.py (path:/tmp/pip-hGLFV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:44 INFO - Running setup.py (path:/tmp/pip-15W2Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:44 INFO - Running setup.py (path:/tmp/pip-ZfT39K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:44 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)) 15:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:44 INFO - Running setup.py (path:/tmp/pip-Gv4c3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:45 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)) 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:45 INFO - Running setup.py (path:/tmp/pip-KX5gkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:45 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)) 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:45 INFO - Running setup.py (path:/tmp/pip-I8KCoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:45 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)) 15:05:45 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)) 15:05:45 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)) 15:05:45 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)) 15:05:45 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)) 15:05:45 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)) 15:05:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:45 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 15:05:45 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 15:05:45 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 15:05:45 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 15:05:45 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 15:05:45 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 15:05:47 INFO - Downloading blessings-1.6.tar.gz 15:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:05:47 INFO - Installing collected packages: blessings 15:05:47 INFO - Running setup.py install for blessings 15:05:47 INFO - Successfully installed blessings 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:05:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:47 INFO - Reading from file tmpfile_stdout 15:05:47 INFO - Current package versions: 15:05:47 INFO - argparse == 1.2.1 15:05:47 INFO - blessings == 1.6 15:05:47 INFO - blobuploader == 1.2.4 15:05:47 INFO - docopt == 0.6.1 15:05:47 INFO - functools32 == 3.2.3-2 15:05:47 INFO - jsonschema == 2.5.1 15:05:47 INFO - manifestparser == 1.1 15:05:47 INFO - mozInstall == 1.12 15:05:47 INFO - mozcrash == 0.17 15:05:47 INFO - mozdebug == 0.1 15:05:47 INFO - mozdevice == 0.48 15:05:47 INFO - mozfile == 1.2 15:05:47 INFO - mozhttpd == 0.7 15:05:47 INFO - mozinfo == 0.9 15:05:47 INFO - mozleak == 0.1 15:05:47 INFO - mozlog == 3.2 15:05:47 INFO - moznetwork == 0.27 15:05:47 INFO - mozprocess == 0.23 15:05:47 INFO - mozprofile == 0.28 15:05:47 INFO - mozrunner == 6.12 15:05:47 INFO - mozscreenshot == 0.1 15:05:47 INFO - mozsystemmonitor == 0.3 15:05:47 INFO - moztest == 0.7 15:05:47 INFO - mozversion == 1.4 15:05:47 INFO - psutil == 3.1.1 15:05:47 INFO - requests == 1.2.3 15:05:47 INFO - wsgiref == 0.1.2 15:05:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:47 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 15:05:47 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 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x13ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', '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 15:05:47 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 15:05:47 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 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Running post-action listener: _resource_record_post_action 15:05:47 INFO - Running post-action listener: _start_resource_monitoring 15:05:48 INFO - Starting resource monitoring. 15:05:48 INFO - ##### 15:05:48 INFO - ##### Finished create-virtualenv step (success) 15:05:48 INFO - ##### 15:05:48 INFO - ##### 15:05:48 INFO - ##### Running install step. 15:05:48 INFO - ##### 15:05:48 INFO - Running pre-action listener: _resource_record_pre_action 15:05:48 INFO - Running main action method: install 15:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:48 INFO - Reading from file tmpfile_stdout 15:05:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:05:48 INFO - Reading from file tmpfile_stdout 15:05:48 INFO - Output received: 15:05:48 INFO - Usage: mozinstall [options] installer 15:05:48 INFO - Options: 15:05:48 INFO - -h, --help show this help message and exit 15:05:48 INFO - -d DEST, --destination=DEST 15:05:48 INFO - Directory to install application into. [default: 15:05:48 INFO - "/builds/slave/test"] 15:05:48 INFO - --app=APP Application being installed. [default: firefox] 15:05:48 INFO - mkdir: /builds/slave/test/build/application 15:05:48 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'] 15:05:48 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 15:06:04 INFO - Reading from file tmpfile_stdout 15:06:04 INFO - Output received: 15:06:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:04 INFO - Running post-action listener: _resource_record_post_action 15:06:04 INFO - ##### 15:06:04 INFO - ##### Finished install step (success) 15:06:04 INFO - ##### 15:06:04 INFO - ##### 15:06:04 INFO - ##### Running run-tests step. 15:06:04 INFO - ##### 15:06:04 INFO - Running pre-action listener: _resource_record_pre_action 15:06:04 INFO - Running main action method: run_tests 15:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:04 INFO - Python 2.7.3 15:06:04 INFO - Return code: 0 15:06:04 INFO - grabbing minidump binary from tooltool 15:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:04 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 0x166b570>, '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 0x166c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:04 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 15:06:04 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 15:06:04 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 15:06:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:04 INFO - Return code: 0 15:06:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:06:04 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:06:04 INFO - Using env: {'DISPLAY': ':0', 15:06:04 INFO - 'HOME': '/home/cltbld', 15:06:04 INFO - 'LANG': 'en_US.UTF-8', 15:06:04 INFO - 'LANGUAGE': 'en_US:en', 15:06:04 INFO - 'LOGNAME': 'cltbld', 15:06:04 INFO - 'MAIL': '/var/mail/cltbld', 15:06:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:04 INFO - 'MOZ_NO_REMOTE': '1', 15:06:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:04 INFO - 'NO_EM_RESTART': '1', 15:06:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:04 INFO - 'PWD': '/builds/slave/test', 15:06:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:04 INFO - 'SHELL': '/bin/bash', 15:06:04 INFO - 'SHLVL': '1', 15:06:04 INFO - 'TERM': 'linux', 15:06:04 INFO - 'TMOUT': '86400', 15:06:04 INFO - 'USER': 'cltbld', 15:06:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864', 15:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:04 INFO - '_': '/tools/buildbot/bin/python'} 15:06:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:06:04 INFO - mozversion application_buildid: 20160713141243 15:06:04 INFO - mozversion application_changeset: 0ec4b1228536dabe17e78060f4413fc91b162d58 15:06:04 INFO - mozversion application_display_name: Nightly 15:06:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:04 INFO - mozversion application_name: Firefox 15:06:04 INFO - mozversion application_remotingname: firefox 15:06:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:04 INFO - mozversion application_vendor: Mozilla 15:06:04 INFO - mozversion application_version: 50.0a1 15:06:04 INFO - mozversion platform_buildid: 20160713141243 15:06:04 INFO - mozversion platform_changeset: 0ec4b1228536dabe17e78060f4413fc91b162d58 15:06:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:04 INFO - mozversion platform_version: 50.0a1 15:06:04 INFO - using testdate: 1468447564 15:06:04 INFO - actual date: 1468447564 15:06:04 INFO - starting webserver on 'localhost:37878' 15:06:04 INFO - SUITE-START | Running 2 tests 15:06:04 INFO - TEST-START | dromaeo_css 15:06:04 INFO - operating with platform_type : linux_ 15:06:04 INFO - Initialising browser for dromaeo_css test... 15:06:04 INFO - TEST-INFO | started process 7668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLWczZ/profile http://localhost:37878/getInfo.html) 15:06:10 INFO - PROCESS | 7668 | __metrics Screen width/height:1600/1200 15:06:10 INFO - PROCESS | 7668 | colorDepth:24 15:06:10 INFO - PROCESS | 7668 | Browser inner width/height: 1024/697 15:06:10 INFO - PROCESS | 7668 | __metrics 15:06:10 ERROR - PROCESS | 7668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:06:11 INFO - TEST-INFO | 7668: exit 0 15:06:11 INFO - Browser initialized. 15:06:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:11 INFO - TEST-INFO | started process 7788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLWczZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:23 INFO - PROCESS | 7788 | RSS: Main: 169025536 15:06:23 INFO - PROCESS | 7788 | 15:07:13 INFO - PROCESS | 7788 | 1468447633176 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] 15:09:25 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37878/tests/dromaeo/cssquery-ext.html) 15:09:26 INFO - PROCESS | 7788 | RSS: Main: 171458560 15:09:26 INFO - PROCESS | 7788 | 15:12:29 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-ext.html (next: http://localhost:37878/tests/dromaeo/cssquery-jquery.html) 15:12:29 INFO - PROCESS | 7788 | RSS: Main: 168706048 15:12:29 INFO - PROCESS | 7788 | 15:15:31 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37878/tests/dromaeo/cssquery-mootools.html) 15:15:32 INFO - PROCESS | 7788 | RSS: Main: 171941888 15:15:32 INFO - PROCESS | 7788 | 15:18:34 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37878/tests/dromaeo/cssquery-prototype.html) 15:18:34 INFO - PROCESS | 7788 | RSS: Main: 167763968 15:18:34 INFO - PROCESS | 7788 | 15:21:37 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37878/tests/dromaeo/cssquery-yui.html) 15:21:38 INFO - PROCESS | 7788 | RSS: Main: 169500672 15:21:38 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:37878/tests/dromaeo/cssquery-yui.html (next: http://localhost:37878/tests/dromaeo/cssquery-dojo.html) 15:24:41 INFO - PROCESS | 7788 | RSS: Main: 170508288 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | __start_tp_report 15:24:41 INFO - PROCESS | 7788 | _x_x_mozilla_page_load 15:24:41 INFO - PROCESS | 7788 | _x_x_mozilla_page_load_details 15:24:41 INFO - PROCESS | 7788 | |i|pagename|runs| 15:24:41 INFO - PROCESS | 7788 | |0;dojo.html;2610.0864697355923;2617.2017534651936;2629.2506635608847;2647.351398907268;2648.059938721755;4657.883552911179;4709.034647897177;4711.034237981215;4740.07568524138;4750.524947505248;4643.233866412038;4701.882452938678;4702.811887524504;4708.929366059503;4719.764011799413;4300.655947524198;4373.562643735617;4409;4434.290513517838;4447;169.68485438150535;4183.518895327046;4324.286492728696;4334.84828031019;4390.758508282043;4364.236258654722;4374.825006999717;4381.583749543788;4404.031113155101;4450.621697155746;4371.475422949266;4388.605025547716;4396.3625274335045;4434.667399945017;4459.509453960061;4241.088166044316;4281.400603915455;4308.870733877958;4359.237133501656;4366.19225443294;4700.224462963607;4705.835295764632;4713.104510143096;4720.126776546315;4725.929111063337;4825.10735513931;4969.552740253394;5033.697978121324;5054.494550544916;5062.493750624945;5007.84976450707;5008.223725322581;5008.5993120550265;5010.448850626428;5040;4684.1334353144775;4725.669203155815;4727.905441891212;4733.479317275097;4789.640776941708;5141.100307446182;5179;5181.844544663666;5204.115300398866;5228.503292187236;4984;4989.301497790312;4989.825356112518;4989.975050124799;5033.1695270280725;5030.346055012898;5081.339425874613;5087.084324821493;5088.745562721923;5091.87270318245;4959.181735013754;4985.52637499437;4988.201887697951;5006.849794506098;5019.52314530119;4989.950100499022;4993.4756850530175;5011.799528018912;5019.372578427697;5042.596592272609;4058.2492238935893;4205.179989902001;4231.6614670826875;4249.80875860587;4283.7429754214845;3587.9641203588153;3723.72072094594;3766.849326026983;3794.5067141271456;3799.6200379961783;4347.826086956549;4360.847370342023;4366.388705581221;4422.181896349186;4460.8661740147845;4945.752712364368;5102.336696229467;5104.464031276662;5109.054824857413;5115.5396014358885;4337.9132417351475;4378.584034516716;4384.013596940663;4391.626711729475;4393.033532622818;4511.8646440606835;4520.254158063883;4520.841770538082;4560.201964656172;4571.748553829571;4628.051249493778;4710.764461776897;4771.761411929459;4791.377120974251;4792.568668819823;5068.695878247317;5087.974560127176;5103.362079740033;5129.846104616868;5171.095058364695;4830.95169048305;4859.149648811514;4874.610031197567;4876.634252431011;4918.877028074184;4835.226363781778;4942.678725882806;4970.378702662168;5047.899042019212;5105;5094.388673359221;5104.489551044866;5109.744512774272;5112.028714544224;5157.045946499909;4962.578180854668;4966.056449274626;4971.204607262821;4982.701037937735;5013.573846223112;4901.534354236342;4914.0908931847725;4944.134776414041;4967.900641987212;4970.552650261494;4825.300331451849;4855.684380515255;4866.683665561727;4896.632752543503;4900.558949694545;4791.377120974251;4974.726390048582;4985.152524070989;4987.975060124676;5043.773030213576;4849.975750121227;4895.069936712013;4909.803607855646;4911.803527858846;4920.507949205051 15:24:41 INFO - PROCESS | 7788 | |1;ext.html;557.6737608499028;567.937526872044;577.7198058941416;580.8083332500275;597.2027343496437;36296.63703362965;39693.60306396935;39777.005574860574;39796;39865;39328.80335598318;39887.80056099715;39921.800390998;40003.19993600126;40004.39993400101;7733.458657893935;7890.723824666138;7892.0529536455415;7894.960525197394;7897;7807.921920780776;7861.8820717689;7862.567558784264;7869.134395216522;7884.250996155356;7945.602719863984;7953.045634523836;7954.363650907913;7955;7985.880211796828;7845.764627061198;7860.292573668397;7872.212778722139;7886.447948643598;7913.169117242722;7807.180246074194;7811.1017233018365;7836.138024817265;7865.842683146305;7866.292033716935;37630.62369376299;38090.42864357037;38160.80919595384;38262.23475530501;38398.61601383978;2952.291450051972;2956.7486763625116;2977.493826049577;3150.826446280988;3287.424700677396;28901.710982890112;29937.550936735966;30055.398892022255;30177.698223017927;30990.225244368845;2852.6006359109533;2948.292409821627;2975.538791487323;2985.462616728988;3018;258770;260719;260829;262052.99999999808;263626;55039.17441238384;55767.16349254765;55834.44165558292;55855.720721396945;55910;32363.24912382427;33465.16337091592;33477.83261083679;35480.46779298312;35517.112072198404;13511.121777084458;13586.184828910296;13621.523246686318;13680.589582312547;13695.452181912611;9679.467629280458;9716.854247186298;9718.611255549698;9737.707868763948;9741.756456088655;18197.818021819614;18240.361587344643;18263.269469221348;18284.725729114074;18327.63344733098;6869.896951545731;6919.9932019713715;6928.965355173192;6941.548799328028;7179.605121718251;796.8366484870587;897.2732087009543;923.4828496042238;994.1847684898459;996.8704068471052;27073.729262707122;27355.86322068377;27405.62666493383;28077.71922280751;28098.85950570234;865.9350548708746;949.5157469690507;958.8609651600478;961.1493827962304;1013;14325.57023289303;14578.708425831424;14585.343659535347;14623.78064329036;14703.852961470462;350156;355313;355526;357337;358182;49097.75451122721;49184.75407622939;49475.752621237385;49537.25694114591;49745;1179.6225207933378;1188.4592510407917;1189.6550000499758;1195.1872726545857;1198.5445530698453;26218.344541386617;27133.1860044199;27215.911363546027;27689.169324920284;27797.16608501748;41499.37750933799;41878.162436750485;41991.16017679568;42078;42089.36865947075;324477;326760;327247;327681;328891;24664.260072197863;24833.379165521008;25749.871250644377;25839.483210336064;26680.8665956669;41491.7925410371;41558;42136.36795448132;42166;42441.575584243765;36161.81919090493;36174.4573831398;37181.25637487289;37235.49946963;37235.81382093072;36311.45532816957;36823.815880920425;36895;37058.8147059263;37700.24599508049;32605.510917336735;35338.46992295066;36000;36296.63703363038;36551.817240913624;31846.522302165024;32886;33654.49518257277;33952.320953580296;34044.829775850965;25688.229353119437;25882.48235035251;25918.092866749572;26012.34969125787;26041.348966275993 15:24:41 INFO - PROCESS | 7788 | |2;jquery.html;377.77144827379436;377.7884384744543;380.12950343712896;393.52776667998376;396.71436565672724;16174.91912540437;17938.37215697451;17982.5504362391;18744.718829217574;18761.15574799134;16445.753313700276;16974.15129243536;17248.741268880978;17250.741238881426;17339.306427742875;5120.283160357553;5260.973695131519;5293.68237905725;5298.311219541454;5313.73431328434;3823.273578020181;5825.533957283407;6181;6193.2877719062435;6256.562040657156;6100.96949515254;6210.254769427653;6215.844603884894;6225.8132256032395;6236.438720515152;6138.969305153446;6149.754009839578;6149.815505534841;6185.505159587245;6189.9381006189815;5255.76349064293;5405.297311349539;5483.314585676791;5485.588580856412;5507.779688812443;20832.27087051946;21065.157393704234;21349.146034158613;21491.355259342246;21495;1769.0447158534375;1805.9796215138406;1830.4600142957859;2106.8630539014916;2211.7456492503406;13545.52590659332;13663.316834158253;13674.31628418575;13842.515511957034;13861.168329900238;1681.6468541606278;1708.6924353616344;1731.3247833345006;1743.320105158989;1792.5339411752907;70255.29744702538;72999.63500182464;73081.6345918267;73748.63125684338;74427;9025.954870225607;9029.23251523628;9365.438073715599;9588.185004274716;9595.616175353047;12937;13002;13002.674933126558;13046.478140874258;13050.477980880849;7153.4992550520965;7213.963930180315;7298.4891057625455;7395.519291246052;7444.516106453063;7032.437405007587;7116.217216106224;7127.857442851114;7189.856202876018;7264.237255088246;5425.647332923348;6012.398760123952;6020.969895150496;6059.121427393004;6106.267247930276;1612.5726682429165;1737.860971122307;1787.3922866225287;1794.120880768414;1844.1424737497127;823.1439303124683;854.5641722721333;864.0409145848104;869.7912500999714;960.274992380748;17055.317787288368;17213.31146754116;17807.821921780618;18014.729779053323;18026.36907708224;841.3479553346083;845.0788640382013;879.046234835211;894.8612964990436;956.5121787888227;10036.447995360179;10248.180145588483;10255.487225638688;10283.331583447052;10333.844992325121;329898;331006;331934;346780;363366;40750.388744168864;48358.758206208746;68835.31164688389;73876.63061684657;75540.62229688927;839.6053854688287;879.6657270237397;880.8370451466499;887.6538150121457;894.7852515396388;15965.840341596435;16143.919280403523;16401.261943212823;16469.752953705465;16938.068406237777;38954.4156837642;39779.60220397759;41241;41874.581254188284;42137.36793948032;47792.522074778804;47813.04373912572;48090.27864582104;49496.75251623719;50648.24027639515;7265.564066156047;7271.127464704269;7412.96293518529;7494.288042635941;7573.091229052549;10857.891421085687;10876.836847447454;11168;11480.655580332603;11583.247088939192;9462.57418416159;9465.337426380363;9484.905150948678;9724.854127188239;9932.404055756677;9654.662086826927;9725.416475011521;9765.267604929517;9835.803283934138;9843.557039933077;9440.527973601429;9617.374870633386;9628.18160456341;9800.215982721507;10042.598296068367;6144.2319710036245;6152.230971128609;6247.625142491465;6347.96826015867;6404.391582799627;9174.816503669756;9193.77015574616;9214.078592141;9548.665796697082;9617.855732163884 15:24:41 INFO - PROCESS | 7788 | |3;mootools.html;1382.1361648969394;1413.590058882924;1505.4806091898292;1681.3442757324653;1712.7773389459376;6750.864982700343;7514.887276690854;7885.84228315434;8204.876926846102;8260.71087511938;7898.328642065417;7910.090339610946;7982.680692772296;7992.640331185096;8004.159563245863;2221.4113259986075;2273.1134857405623;2282;2283.9657405138855;2284.3832165315357;2136.9893150534226;2164.2641501889357;2234.26844195748;2249.167807911075;2258.9209377671787;2157.967630485544;2164.9025793839314;2178.6078505868936;2181.454636340915;2187.7593464718866;2174.239016344267;2184.1154332495366;2188.4528867783056;2201.6587428948537;2209.5912256232486;2122.904469298885;2143.9464013399634;2145.495808485005;2148.4199266198193;2154.7306586676664;8017.398695097891;8026.478278911911;8045.919540804575;8064.8387032259025;8089.352851771903;4517.186906356855;4611.077784443125;4690.061987602493;4693.20215563355;4700.1539722849875;2641.168032069892;2716.456708658276;2751.284665986858;2776.625155603988;2824.9435011299865;839.9496030238145;854.9358798090168;860.0496451421152;871.3116637856086;888.7111688701198;10890.61882834097;10901.509432075654;10939.234253602252;10958.178136639784;10960.12319014477;4154.480689913761;4193.601607847249;4364.8472303469225;4366.3013917773005;4381.2989921613025;9331.206847418045;9333;9387.5306234688;9393.060693930689;9417.293702972305;4712.387389639325;4718.834840780556;4723.645726570452;4725.3384526166365;4728.787204575802;3581.28374325136;4108.157827645326;4224.239636865394;4259.723117997382;4266.317389217772;3722.3113723961155;3779.60314167014;3814.713896457721;3856.7107466940092;3917.5886531914307;1187.54279602352;1210.0501106631252;1217.1054275107788;1219.116140797932;1222.7798996180773;811.6063709101081;816.4121832280748;842.2335674536142;847.9830403391898;852.7910661887877;5144.202648589475;5237.450067742909;5301.54936830366;5380.192971054373;5407.242985981966;412.0810592378952;417.764957477493;421.62686022869366;427.95934386233256;429.7657776511809;3555.928881422357;3743.3449146399817;3762.492063571383;3791.1659434924272;3852.730308878408;9509;9816.901830981742;9827.754306142404;9866.80266394668;9911.306208565331;9613;9785.902140978498;9806.65676701312;9809.411435313905;9827;7440.553566785902;7474.850502990019;7502.062242219723;7528.924710752932;7549.471536992358;5150.8969820604125;5304.336957880265;5403.756830942539;5448.0465918463315;5482.2873026506295;8825.867611985697;8987.55062246872;9176.311776616647;9185.724428267162;9212.401193922373;9146.176844084064;9195.86206206894;9225.446473211361;9233.676821311223;9307.06929307064;6197.163382943245;6286.748530058747;6558.573692709959;6883.208431030495;6936.4797640176175;7689.6539655714505;7698.153203147761;7708.152103268524;7737.381009519338;7741.845163096819;6796;6998.580085194904;7000.719971201095;7051.788446346618;7112.928870711226;6778.389944904982;6840.31596840312;6870.381665650116;6915.827104322432;6947.478939079489;6503.666748316678;6535.44448721864;6566.507511936528;6577.539572229898;6587.077809106633;4540;4583.495815460364;4614.353990441274;4669.813207471799;4767.237242041257;4577.3591697161755;4602.723836569817;4605.953940460552;4608.746518941491;4740.668153229379 15:24:41 INFO - PROCESS | 7788 | |4;prototype.html;294.9601803756492;301.4573767219005;309.37814991866355;311.9079871437926;313.70355014511296;4853.927191092128;4947.307376967227;5040.117979353612;5082.6365739930925;5101.081805275054;4979.502049795019;4989.975050124754;4996.675216110959;5009.048280826641;5034.375249820124;3944.23087497938;3954.3787047310607;3968.464257325253;3970.960290397102;3978.8010599470053;3861.1891502784447;3926.4895563576697;3935.3703407454814;3948.723589348747;3951.861684841031;3915.1386694927214;3932.1742434088733;3934.567197608261;3947.9210415791667;3948.5853985331414;3931.429942658313;3939.606039396066;3943.960560394388;3944.5996671181606;3952.332175781336;3477.9652203477895;3485.268093700326;3487.686108250244;3493.510908472816;3496.965030349689;4617.515160908123;4944.307796908436;4950.851474455736;4965.925511117336;4969.676970996909;4435.534268901751;4439.600435960779;4452.643788496913;4468.151051300242;4472.418585583886;5281.735913204363;5294.814681486129;5302.787888484456;5303.7348132593215;5309.283246761676;3614;3717.70258379329;3724.925501489955;3728.738988270822;3749.5376803046834;5523.392426833045;5539.695316757577;5556.583256255756;5568.693721845257;5570.192322113271;3733.3466643337306;3747.306748251582;3748.475213470116;3766.4915236443276;3771.189194323179;3737.6075512071384;3807.9809600951817;3813.866514671973;3814.4469051987307;3830.693544516432;4348.652107831366;4406.955930440655;4408.823647054082;4421.845235416745;4442.8667139985855;5268.631195816256;5286.7092309922555;5293.338332708411;5293.417724050351;5304.336957880265;1252.991341969705;1286.9254172765845;1316.414195682912;1324.5364122557028;1325.734853029398;879.4591326334258;887.4985633117398;888.8666699994923;901.9942763818426;907.4827348411474;4579.358889755437;4599.9080018399445;4612.331211974312;4614.146382919171;4618.261078227468;5331.413544510101;5340.49265319794;5347.385050719217;5407.864803379868;5412.107002344648;4414.624756895636;4598.471175814757;4604.677672562889;4617.815287388534;4633.911030907734;2521.571332873416;2551;2554.5657238269537;2556.6037264224074;2561.5261176682375;4498.730076195438;4520.344550040226;4566.771661416916;4592.242280023758;4599.5400459953735;4657.580817726421;4863.027394521039;4866.586340161126;4884.438289596671;4886.682365646293;4481.910361792746;4488.765589462859;4527.343535187445;4530.343100250511;4551;4705.7647117644665;4762.951710905093;4772.642051846056;4791.616670666408;4819.903601928012;4526.796294166705;4690.9765451172525;4692.976535117303;4703.647226458098;4733;4441.422615060022;4532.0256144929;4539.568740969603;4543.547323622802;4557.589816916494;3433.570803649544;3450.6549345066296;3464.514967904445;3469.6183419824306;3475.913102172466;4757.524247575215;4773.832915847928;4779.737114458599;4781.9043619128115;5121.206213036985;5038.697678139323;5279.260903473593;5279.762410691451;5284.630075894651;5299.39057008449;5260.763265652979;5284.603654725988;5298.549623282064;5303.15149576066;5310.8937821244135;4958.578520825626;5184.559312458483;5195.480451954774;5235.712035838065;5255.421903590678;5361.892762144813;5371.435999220182;5378.73106344689;5391.676499410048;5402.972985135049;5256.579473642023;5259.184826351921;5269.1832765921345;5291.068759902685;5301.469853014668 15:24:41 INFO - PROCESS | 7788 | |5;yui.html;590.3476658292586;598.8023952095809;601.7352364959418;626.6334194496219;676.5399528320743;12474.126811123213;13639.181649101036;13765.518206862762;13795.103318284304;13801.585952421417;12869;13311.534096306632;13561.660958476043;13608.52370167042;13612.863871361284;765.1850778920445;784.3058892879785;788.3377962511489;788.4047544104193;790.020374735327;791.9762407127795;797.8603744344746;798.8562058829408;798.8641930871765;799.3525244551903;836.9455985360962;838.786109542069;839.3201506779498;840.9873851892227;844.2275318083946;822.9177082291753;828.668532586967;829.1087081387473;829.274384913201;831.1605278668528;610.5298919831705;612.9141920131185;613.098744845077;614.7448808744366;614.9631022138641;11923.821142682868;12037.699057523545;12097.57658481949;12112.031037517065;12113.576024839176;9787.90212097877;9812.125117731608;9815;10069.69790906274;10260.897391026143;8834.160754728355;9022.593983270768;9075.18323350895;9173.58718857653;9261.72214833556;3193.457112290916;3241.6920392562906;3258.6415494295607;3269.8365081746056;3285.737141028712;58683.706581467246;61207.38792612106;61318.080228796156;62087.37912620906;62235.066474002924;7584.54492730438;7657.157712651604;7721;7725.343345815556;7733.535987840747;16634.417795377103;17555.912220438815;17567.73648395275;17595.384161554284;17627.206775695126;6690.029945657852;6754.358335958076;6791.898121528181;6855.897161542581;6937.375636192767;3476.1657202271776;3477.426224672901;3499.807510586891;3508.6842184203542;3712.6658600726064;2842.4030953499996;2944.4258369618146;2961.6742158362563;2965.9703402966124;2969.985150074279;465.5600457567566;481.93250953410177;482.6356101143614;486.6107114308539;497.437895178446;497.5397757074691;504.7097918696764;510.54306395775575;521.5228066319276;524.2346174585073;7191.532550384209;7306.305900939402;7433.962830185923;7445.441591880631;7477.738279160203;364.3041790180742;425.9957400426018;428.7534667566162;488.8069212660979;508.7786812736471;3300.966990330066;3436.467347561132;3534.5581802274714;3602.7297952653657;3705.221903400316;68928.31071689219;91631.08368916226;95561;97320;98599;45789.77105114453;54706.179407308126;79221.20778792254;80634;84683;75707.62146189345;75821;76230.23769762342;77037.6148119267;77124.22875771283;6217.316095229611;6271.122042914087;6608.70260838273;6765.154355705537;6883.965580172067;34108;35094.649053509136;39475.60524394834;44410.777946110065;44954;63757.362426376996;64828.43443610458;64941.35058649542;65157.34842651703;65513.67243163945;8101.189881011852;8246;8374.916250837414;8460.238578527962;8539.103394143774;9299.628014879328;9307.627694892128;9448.95275523618;11856.644300670994;12049.638510844688;10873.401962892116;10895.891041089488;11281.43592820372;11567.190296679151;11893;11103.555857765921;11501.769964600828;11625.418729063682;11634.70913227176;12168.695782605151;10526.263161578616;10782.406967616856;11113.388763617755;11492.94253528727;11527.423628818693;9390.295727820305;9440.763980900532;9459.905400945903;9510.334276600572;9599.712008639752;8704.26013788835;8735.519546425008;8930.374873759034;9120.817583648422;9426.010268921938 15:24:41 INFO - PROCESS | 7788 | __end_tp_report 15:24:41 INFO - PROCESS | 7788 | __start_cc_report 15:24:41 INFO - PROCESS | 7788 | _x_x_mozilla_cycle_collect,413 15:24:41 INFO - PROCESS | 7788 | __end_cc_report 15:24:41 INFO - PROCESS | 7788 | __startTimestamp1468448681488__endTimestamp 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | ------- Summary: start ------- 15:24:41 INFO - PROCESS | 7788 | Number of tests: 6 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#0] dojo.html Cycles:165 Average:4652.25 Median:4825.30 stddev:605.48 (12.5%) stddev-sans-first:585.76 15:24:41 INFO - PROCESS | 7788 | Values: 2610.1 2617.2 2629.3 2647.4 2648.1 4657.9 4709.0 4711.0 4740.1 4750.5 4643.2 4701.9 4702.8 4708.9 4719.8 4300.7 4373.6 4409.0 4434.3 4447.0 169.7 4183.5 4324.3 4334.8 4390.8 4364.2 4374.8 4381.6 4404.0 4450.6 4371.5 4388.6 4396.4 4434.7 4459.5 4241.1 4281.4 4308.9 4359.2 4366.2 4700.2 4705.8 4713.1 4720.1 4725.9 4825.1 4969.6 5033.7 5054.5 5062.5 5007.8 5008.2 5008.6 5010.4 5040.0 4684.1 4725.7 4727.9 4733.5 4789.6 5141.1 5179.0 5181.8 5204.1 5228.5 4984.0 4989.3 4989.8 4990.0 5033.2 5030.3 5081.3 5087.1 5088.7 5091.9 4959.2 4985.5 4988.2 5006.8 5019.5 4990.0 4993.5 5011.8 5019.4 5042.6 4058.2 4205.2 4231.7 4249.8 4283.7 3588.0 3723.7 3766.8 3794.5 3799.6 4347.8 4360.8 4366.4 4422.2 4460.9 4945.8 5102.3 5104.5 5109.1 5115.5 4337.9 4378.6 4384.0 4391.6 4393.0 4511.9 4520.3 4520.8 4560.2 4571.7 4628.1 4710.8 4771.8 4791.4 4792.6 5068.7 5088.0 5103.4 5129.8 5171.1 4831.0 4859.1 4874.6 4876.6 4918.9 4835.2 4942.7 4970.4 5047.9 5105.0 5094.4 5104.5 5109.7 5112.0 5157.0 4962.6 4966.1 4971.2 4982.7 5013.6 4901.5 4914.1 4944.1 4967.9 4970.6 4825.3 4855.7 4866.7 4896.6 4900.6 4791.4 4974.7 4985.2 4988.0 5043.8 4850.0 4895.1 4909.8 4911.8 4920.5 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#1] ext.html Cycles:180 Average:46511.47 Median:36859.41 stddev:83287.71 (226.0%) stddev-sans-first:83449.89 15:24:41 INFO - PROCESS | 7788 | Values: 557.7 567.9 577.7 580.8 597.2 36296.6 39693.6 39777.0 39796.0 39865.0 39328.8 39887.8 39921.8 40003.2 40004.4 7733.5 7890.7 7892.1 7895.0 7897.0 7807.9 7861.9 7862.6 7869.1 7884.3 7945.6 7953.0 7954.4 7955.0 7985.9 7845.8 7860.3 7872.2 7886.4 7913.2 7807.2 7811.1 7836.1 7865.8 7866.3 37630.6 38090.4 38160.8 38262.2 38398.6 2952.3 2956.7 2977.5 3150.8 3287.4 28901.7 29937.6 30055.4 30177.7 30990.2 2852.6 2948.3 2975.5 2985.5 3018.0 258770.0 260719.0 260829.0 262053.0 263626.0 55039.2 55767.2 55834.4 55855.7 55910.0 32363.2 33465.2 33477.8 35480.5 35517.1 13511.1 13586.2 13621.5 13680.6 13695.5 9679.5 9716.9 9718.6 9737.7 9741.8 18197.8 18240.4 18263.3 18284.7 18327.6 6869.9 6920.0 6929.0 6941.5 7179.6 796.8 897.3 923.5 994.2 996.9 27073.7 27355.9 27405.6 28077.7 28098.9 865.9 949.5 958.9 961.1 1013.0 14325.6 14578.7 14585.3 14623.8 14703.9 350156.0 355313.0 355526.0 357337.0 358182.0 49097.8 49184.8 49475.8 49537.3 49745.0 1179.6 1188.5 1189.7 1195.2 1198.5 26218.3 27133.2 27215.9 27689.2 27797.2 41499.4 41878.2 41991.2 42078.0 42089.4 324477.0 326760.0 327247.0 327681.0 328891.0 24664.3 24833.4 25749.9 25839.5 26680.9 41491.8 41558.0 42136.4 42166.0 42441.6 36161.8 36174.5 37181.3 37235.5 37235.8 36311.5 36823.8 36895.0 37058.8 37700.2 32605.5 35338.5 36000.0 36296.6 36551.8 31846.5 32886.0 33654.5 33952.3 34044.8 25688.2 25882.5 25918.1 26012.3 26041.3 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#2] jquery.html Cycles:180 Average:22829.33 Median:5415.47 stddev:56393.95 (1041.3%) stddev-sans-first:56526.96 15:24:41 INFO - PROCESS | 7788 | Values: 377.8 377.8 380.1 393.5 396.7 16174.9 17938.4 17982.6 18744.7 18761.2 16445.8 16974.2 17248.7 17250.7 17339.3 5120.3 5261.0 5293.7 5298.3 5313.7 3823.3 5825.5 6181.0 6193.3 6256.6 6101.0 6210.3 6215.8 6225.8 6236.4 6139.0 6149.8 6149.8 6185.5 6189.9 5255.8 5405.3 5483.3 5485.6 5507.8 20832.3 21065.2 21349.1 21491.4 21495.0 1769.0 1806.0 1830.5 2106.9 2211.7 13545.5 13663.3 13674.3 13842.5 13861.2 1681.6 1708.7 1731.3 1743.3 1792.5 70255.3 72999.6 73081.6 73748.6 74427.0 9026.0 9029.2 9365.4 9588.2 9595.6 12937.0 13002.0 13002.7 13046.5 13050.5 7153.5 7214.0 7298.5 7395.5 7444.5 7032.4 7116.2 7127.9 7189.9 7264.2 5425.6 6012.4 6021.0 6059.1 6106.3 1612.6 1737.9 1787.4 1794.1 1844.1 823.1 854.6 864.0 869.8 960.3 17055.3 17213.3 17807.8 18014.7 18026.4 841.3 845.1 879.0 894.9 956.5 10036.4 10248.2 10255.5 10283.3 10333.8 329898.0 331006.0 331934.0 346780.0 363366.0 40750.4 48358.8 68835.3 73876.6 75540.6 839.6 879.7 880.8 887.7 894.8 15965.8 16143.9 16401.3 16469.8 16938.1 38954.4 39779.6 41241.0 41874.6 42137.4 47792.5 47813.0 48090.3 49496.8 50648.2 7265.6 7271.1 7413.0 7494.3 7573.1 10857.9 10876.8 11168.0 11480.7 11583.2 9462.6 9465.3 9484.9 9724.9 9932.4 9654.7 9725.4 9765.3 9835.8 9843.6 9440.5 9617.4 9628.2 9800.2 10042.6 6144.2 6152.2 6247.6 6348.0 6404.4 9174.8 9193.8 9214.1 9548.7 9617.9 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#3] mootools.html Cycles:180 Average:5219.58 Median:5147.55 stddev:2970.29 (57.7%) stddev-sans-first:2964.62 15:24:41 INFO - PROCESS | 7788 | Values: 1382.1 1413.6 1505.5 1681.3 1712.8 6750.9 7514.9 7885.8 8204.9 8260.7 7898.3 7910.1 7982.7 7992.6 8004.2 2221.4 2273.1 2282.0 2284.0 2284.4 2137.0 2164.3 2234.3 2249.2 2258.9 2158.0 2164.9 2178.6 2181.5 2187.8 2174.2 2184.1 2188.5 2201.7 2209.6 2122.9 2143.9 2145.5 2148.4 2154.7 8017.4 8026.5 8045.9 8064.8 8089.4 4517.2 4611.1 4690.1 4693.2 4700.2 2641.2 2716.5 2751.3 2776.6 2824.9 839.9 854.9 860.0 871.3 888.7 10890.6 10901.5 10939.2 10958.2 10960.1 4154.5 4193.6 4364.8 4366.3 4381.3 9331.2 9333.0 9387.5 9393.1 9417.3 4712.4 4718.8 4723.6 4725.3 4728.8 3581.3 4108.2 4224.2 4259.7 4266.3 3722.3 3779.6 3814.7 3856.7 3917.6 1187.5 1210.1 1217.1 1219.1 1222.8 811.6 816.4 842.2 848.0 852.8 5144.2 5237.5 5301.5 5380.2 5407.2 412.1 417.8 421.6 428.0 429.8 3555.9 3743.3 3762.5 3791.2 3852.7 9509.0 9816.9 9827.8 9866.8 9911.3 9613.0 9785.9 9806.7 9809.4 9827.0 7440.6 7474.9 7502.1 7528.9 7549.5 5150.9 5304.3 5403.8 5448.0 5482.3 8825.9 8987.6 9176.3 9185.7 9212.4 9146.2 9195.9 9225.4 9233.7 9307.1 6197.2 6286.7 6558.6 6883.2 6936.5 7689.7 7698.2 7708.2 7737.4 7741.8 6796.0 6998.6 7000.7 7051.8 7112.9 6778.4 6840.3 6870.4 6915.8 6947.5 6503.7 6535.4 6566.5 6577.5 6587.1 4540.0 4583.5 4614.4 4669.8 4767.2 4577.4 4602.7 4606.0 4608.7 4740.7 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#4] prototype.html Cycles:180 Average:4236.83 Median:4608.50 stddev:1232.77 (26.7%) stddev-sans-first:1200.20 15:24:41 INFO - PROCESS | 7788 | Values: 295.0 301.5 309.4 311.9 313.7 4853.9 4947.3 5040.1 5082.6 5101.1 4979.5 4990.0 4996.7 5009.0 5034.4 3944.2 3954.4 3968.5 3971.0 3978.8 3861.2 3926.5 3935.4 3948.7 3951.9 3915.1 3932.2 3934.6 3947.9 3948.6 3931.4 3939.6 3944.0 3944.6 3952.3 3478.0 3485.3 3487.7 3493.5 3497.0 4617.5 4944.3 4950.9 4965.9 4969.7 4435.5 4439.6 4452.6 4468.2 4472.4 5281.7 5294.8 5302.8 5303.7 5309.3 3614.0 3717.7 3724.9 3728.7 3749.5 5523.4 5539.7 5556.6 5568.7 5570.2 3733.3 3747.3 3748.5 3766.5 3771.2 3737.6 3808.0 3813.9 3814.4 3830.7 4348.7 4407.0 4408.8 4421.8 4442.9 5268.6 5286.7 5293.3 5293.4 5304.3 1253.0 1286.9 1316.4 1324.5 1325.7 879.5 887.5 888.9 902.0 907.5 4579.4 4599.9 4612.3 4614.1 4618.3 5331.4 5340.5 5347.4 5407.9 5412.1 4414.6 4598.5 4604.7 4617.8 4633.9 2521.6 2551.0 2554.6 2556.6 2561.5 4498.7 4520.3 4566.8 4592.2 4599.5 4657.6 4863.0 4866.6 4884.4 4886.7 4481.9 4488.8 4527.3 4530.3 4551.0 4705.8 4763.0 4772.6 4791.6 4819.9 4526.8 4691.0 4693.0 4703.6 4733.0 4441.4 4532.0 4539.6 4543.5 4557.6 3433.6 3450.7 3464.5 3469.6 3475.9 4757.5 4773.8 4779.7 4781.9 5121.2 5038.7 5279.3 5279.8 5284.6 5299.4 5260.8 5284.6 5298.5 5303.2 5310.9 4958.6 5184.6 5195.5 5235.7 5255.4 5361.9 5371.4 5378.7 5391.7 5403.0 5256.6 5259.2 5269.2 5291.1 5301.5 15:24:41 INFO - PROCESS | 7788 | 15:24:41 INFO - PROCESS | 7788 | [#5] yui.html Cycles:180 Average:16541.16 Median:614.85 stddev:24100.86 (3919.8%) stddev-sans-first:24138.71 15:24:41 INFO - PROCESS | 7788 | Values: 590.3 598.8 601.7 626.6 676.5 12474.1 13639.2 13765.5 13795.1 13801.6 12869.0 13311.5 13561.7 13608.5 13612.9 765.2 784.3 788.3 788.4 790.0 792.0 797.9 798.9 798.9 799.4 836.9 838.8 839.3 841.0 844.2 822.9 828.7 829.1 829.3 831.2 610.5 612.9 613.1 614.7 615.0 11923.8 12037.7 12097.6 12112.0 12113.6 9787.9 9812.1 9815.0 10069.7 10260.9 8834.2 9022.6 9075.2 9173.6 9261.7 3193.5 3241.7 3258.6 3269.8 3285.7 58683.7 61207.4 61318.1 62087.4 62235.1 7584.5 7657.2 7721.0 7725.3 7733.5 16634.4 17555.9 17567.7 17595.4 17627.2 6690.0 6754.4 6791.9 6855.9 6937.4 3476.2 3477.4 3499.8 3508.7 3712.7 2842.4 2944.4 2961.7 2966.0 2970.0 465.6 481.9 482.6 486.6 497.4 497.5 504.7 510.5 521.5 524.2 7191.5 7306.3 7434.0 7445.4 7477.7 364.3 426.0 428.8 488.8 508.8 3301.0 3436.5 3534.6 3602.7 3705.2 68928.3 91631.1 95561.0 97320.0 98599.0 45789.8 54706.2 79221.2 80634.0 84683.0 75707.6 75821.0 76230.2 77037.6 77124.2 6217.3 6271.1 6608.7 6765.2 6884.0 34108.0 35094.6 39475.6 44410.8 44954.0 63757.4 64828.4 64941.4 65157.3 65513.7 8101.2 8246.0 8374.9 8460.2 8539.1 9299.6 9307.6 9449.0 11856.6 12049.6 10873.4 10895.9 11281.4 11567.2 11893.0 11103.6 11501.8 11625.4 11634.7 12168.7 10526.3 10782.4 11113.4 11492.9 11527.4 9390.3 9440.8 9459.9 9510.3 9599.7 8704.3 8735.5 8930.4 9120.8 9426.0 15:24:41 INFO - PROCESS | 7788 | -------- Summary: end -------- 15:24:41 INFO - PROCESS | 7788 | 15:24:42 INFO - TEST-INFO | 7788: exit 0 15:24:42 INFO - TEST-OK | dromaeo_css | took 1117377ms 15:24:42 INFO - TEST-START | kraken 15:24:42 INFO - operating with platform_type : linux_ 15:24:42 INFO - Initialising browser for kraken test... 15:24:42 INFO - TEST-INFO | started process 8037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuI0tr/profile http://localhost:37878/getInfo.html) 15:24:47 INFO - PROCESS | 8037 | __metrics Screen width/height:1600/1200 15:24:47 INFO - PROCESS | 8037 | colorDepth:24 15:24:47 INFO - PROCESS | 8037 | Browser inner width/height: 1024/697 15:24:47 INFO - PROCESS | 8037 | __metrics 15:24:47 ERROR - PROCESS | 8037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:24:48 INFO - TEST-INFO | 8037: exit 0 15:24:48 INFO - Browser initialized. 15:24:48 INFO - Running cycle 1/1 for kraken test... 15:24:48 INFO - TEST-INFO | started process 8159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuI0tr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:00 INFO - PROCESS | 8159 | RSS: Main: 169189376 15:25:00 INFO - PROCESS | 8159 | 15:25:03 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37878/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:04 INFO - PROCESS | 8159 | RSS: Main: 174235648 15:25:04 INFO - PROCESS | 8159 | 15:25:06 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37878/tests/kraken/driver.html?testName=audio-dft) 15:25:07 INFO - PROCESS | 8159 | RSS: Main: 173600768 15:25:07 INFO - PROCESS | 8159 | 15:25:10 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37878/tests/kraken/driver.html?testName=audio-fft) 15:25:11 INFO - PROCESS | 8159 | RSS: Main: 168701952 15:25:11 INFO - PROCESS | 8159 | 15:25:13 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37878/tests/kraken/driver.html?testName=audio-oscillator) 15:25:14 INFO - PROCESS | 8159 | RSS: Main: 170020864 15:25:14 INFO - PROCESS | 8159 | 15:25:16 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:16 INFO - PROCESS | 8159 | RSS: Main: 170213376 15:25:16 INFO - PROCESS | 8159 | 15:25:20 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37878/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:20 INFO - PROCESS | 8159 | RSS: Main: 170557440 15:25:20 INFO - PROCESS | 8159 | 15:25:24 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37878/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:24 INFO - PROCESS | 8159 | RSS: Main: 167890944 15:25:24 INFO - PROCESS | 8159 | 15:25:27 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37878/tests/kraken/driver.html?testName=json-parse-financial) 15:25:28 INFO - PROCESS | 8159 | RSS: Main: 169705472 15:25:28 INFO - PROCESS | 8159 | 15:25:30 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:30 INFO - PROCESS | 8159 | RSS: Main: 169283584 15:25:30 INFO - PROCESS | 8159 | 15:25:32 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:33 INFO - PROCESS | 8159 | RSS: Main: 169922560 15:25:33 INFO - PROCESS | 8159 | 15:25:35 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:36 INFO - PROCESS | 8159 | RSS: Main: 169762816 15:25:36 INFO - PROCESS | 8159 | 15:25:38 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:39 INFO - PROCESS | 8159 | RSS: Main: 170176512 15:25:39 INFO - PROCESS | 8159 | 15:25:42 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:43 INFO - PROCESS | 8159 | RSS: Main: 169594880 15:25:43 INFO - PROCESS | 8159 | 15:25:44 INFO - PROCESS | 8159 | Cycle 1(1): loaded http://localhost:37878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37878/tests/kraken/driver.html?testName=ai-astar) 15:25:45 INFO - PROCESS | 8159 | RSS: Main: 170164224 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | __start_tp_report 15:25:45 INFO - PROCESS | 8159 | _x_x_mozilla_page_load 15:25:45 INFO - PROCESS | 8159 | _x_x_mozilla_page_load_details 15:25:45 INFO - PROCESS | 8159 | |i|pagename|runs| 15:25:45 INFO - PROCESS | 8159 | |0;ai-astar;106;114;110;115;116;116;117;115;115;113 15:25:45 INFO - PROCESS | 8159 | |1;audio-beat-detection;150;123;150;184;125;153;148;127;179;128 15:25:45 INFO - PROCESS | 8159 | |2;audio-dft;163;163;164;165;168;164;163;164;163;164 15:25:45 INFO - PROCESS | 8159 | |3;audio-fft;77;76;76;158;79;77;77;74;160;76 15:25:45 INFO - PROCESS | 8159 | |4;audio-oscillator;87;86;140;86;87;85;147;86;86;145 15:25:45 INFO - PROCESS | 8159 | |5;imaging-gaussian-blur;117;118;118;118;118;118;118;123;118;118 15:25:45 INFO - PROCESS | 8159 | |6;imaging-darkroom;148;147;151;146;147;147;148;147;147;148 15:25:45 INFO - PROCESS | 8159 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;95;95 15:25:45 INFO - PROCESS | 8159 | |8;json-parse-financial;67;68;66;66;67;68;67;68;66;66 15:25:45 INFO - PROCESS | 8159 | |9;json-stringify-tinderbox;66;65;66;65;66;66;66;65;67;65 15:25:45 INFO - PROCESS | 8159 | |10;stanford-crypto-aes;83;80;80;80;80;83;86;79;86;86 15:25:45 INFO - PROCESS | 8159 | |11;stanford-crypto-ccm;134;138;132;138;132;137;135;134;170;143 15:25:45 INFO - PROCESS | 8159 | |12;stanford-crypto-pbkdf2;166;168;166;169;165;165;166;167;166;171 15:25:45 INFO - PROCESS | 8159 | |13;stanford-crypto-sha256-iterative;70;69;66;68;66;66;70;66;65;66 15:25:45 INFO - PROCESS | 8159 | __end_tp_report 15:25:45 INFO - PROCESS | 8159 | __start_cc_report 15:25:45 INFO - PROCESS | 8159 | _x_x_mozilla_cycle_collect,973 15:25:45 INFO - PROCESS | 8159 | __end_cc_report 15:25:45 INFO - PROCESS | 8159 | __startTimestamp1468448745102__endTimestamp 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | ------- Summary: start ------- 15:25:45 INFO - PROCESS | 8159 | Number of tests: 14 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.33 (2.9%) stddev-sans-first:2.07 15:25:45 INFO - PROCESS | 8159 | Values: 106.0 114.0 110.0 115.0 116.0 116.0 117.0 115.0 115.0 113.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:150.00 stddev:21.78 (14.5%) stddev-sans-first:23.07 15:25:45 INFO - PROCESS | 8159 | Values: 150.0 123.0 150.0 184.0 125.0 153.0 148.0 127.0 179.0 128.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 15:25:45 INFO - PROCESS | 8159 | Values: 163.0 163.0 164.0 165.0 168.0 164.0 163.0 164.0 163.0 164.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:34.81 (45.5%) stddev-sans-first:36.44 15:25:45 INFO - PROCESS | 8159 | Values: 77.0 76.0 76.0 158.0 79.0 77.0 77.0 74.0 160.0 76.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:28.00 (32.6%) stddev-sans-first:29.06 15:25:45 INFO - PROCESS | 8159 | Values: 87.0 86.0 140.0 86.0 87.0 85.0 147.0 86.0 86.0 145.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.65 (1.4%) stddev-sans-first:1.67 15:25:45 INFO - PROCESS | 8159 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 118.0 123.0 118.0 118.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.42 15:25:45 INFO - PROCESS | 8159 | Values: 148.0 147.0 151.0 146.0 147.0 147.0 148.0 147.0 147.0 148.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:25:45 INFO - PROCESS | 8159 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 15:25:45 INFO - PROCESS | 8159 | Values: 67.0 68.0 66.0 66.0 67.0 68.0 67.0 68.0 66.0 66.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:25:45 INFO - PROCESS | 8159 | Values: 66.0 65.0 66.0 65.0 66.0 66.0 66.0 65.0 67.0 65.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:2.87 (3.5%) stddev-sans-first:3.03 15:25:45 INFO - PROCESS | 8159 | Values: 83.0 80.0 80.0 80.0 80.0 83.0 86.0 79.0 86.0 86.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:137.50 stddev:11.28 (8.2%) stddev-sans-first:11.81 15:25:45 INFO - PROCESS | 8159 | Values: 134.0 138.0 132.0 138.0 132.0 137.0 135.0 134.0 170.0 143.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.50 stddev:1.91 (1.1%) stddev-sans-first:2.00 15:25:45 INFO - PROCESS | 8159 | Values: 166.0 168.0 166.0 169.0 165.0 165.0 166.0 167.0 166.0 171.0 15:25:45 INFO - PROCESS | 8159 | 15:25:45 INFO - PROCESS | 8159 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.87 (2.8%) stddev-sans-first:1.69 15:25:45 INFO - PROCESS | 8159 | Values: 70.0 69.0 66.0 68.0 66.0 66.0 70.0 66.0 65.0 66.0 15:25:45 INFO - PROCESS | 8159 | -------- Summary: end -------- 15:25:45 INFO - PROCESS | 8159 | 15:25:46 INFO - TEST-INFO | 8159: exit 0 15:25:46 INFO - TEST-OK | kraken | took 63815ms 15:25:46 INFO - SUITE-END | took 1181s 15:25:46 INFO - Completed test suite (00:19:41) 15:25:46 INFO - javascript benchmark 15:25:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6311.747376942736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.0864697355923, 2617.2017534651936, 2629.2506635608847, 2647.351398907268, 2648.059938721755, 4657.883552911179, 4709.034647897177, 4711.034237981215, 4740.07568524138, 4750.524947505248, 4643.233866412038, 4701.882452938678, 4702.811887524504, 4708.929366059503, 4719.764011799413, 4300.655947524198, 4373.562643735617, 4409.0, 4434.290513517838, 4447.0, 169.68485438150535, 4183.518895327046, 4324.286492728696, 4334.84828031019, 4390.758508282043, 4364.236258654722, 4374.825006999717, 4381.583749543788, 4404.031113155101, 4450.621697155746, 4371.475422949266, 4388.605025547716, 4396.3625274335045, 4434.667399945017, 4459.509453960061, 4241.088166044316, 4281.400603915455, 4308.870733877958, 4359.237133501656, 4366.19225443294, 4700.224462963607, 4705.835295764632, 4713.104510143096, 4720.126776546315, 4725.929111063337, 4825.10735513931, 4969.552740253394, 5033.697978121324, 5054.494550544916, 5062.493750624945, 5007.84976450707, 5008.223725322581, 5008.5993120550265, 5010.448850626428, 5040.0, 4684.1334353144775, 4725.669203155815, 4727.905441891212, 4733.479317275097, 4789.640776941708, 5141.100307446182, 5179.0, 5181.844544663666, 5204.115300398866, 5228.503292187236, 4984.0, 4989.301497790312, 4989.825356112518, 4989.975050124799, 5033.1695270280725, 5030.346055012898, 5081.339425874613, 5087.084324821493, 5088.745562721923, 5091.87270318245, 4959.181735013754, 4985.52637499437, 4988.201887697951, 5006.849794506098, 5019.52314530119, 4989.950100499022, 4993.4756850530175, 5011.799528018912, 5019.372578427697, 5042.596592272609, 4058.2492238935893, 4205.179989902001, 4231.6614670826875, 4249.80875860587, 4283.7429754214845, 3587.9641203588153, 3723.72072094594, 3766.849326026983, 3794.5067141271456, 3799.6200379961783, 4347.826086956549, 4360.847370342023, 4366.388705581221, 4422.181896349186, 4460.8661740147845, 4945.752712364368, 5102.336696229467, 5104.464031276662, 5109.054824857413, 5115.5396014358885, 4337.9132417351475, 4378.584034516716, 4384.013596940663, 4391.626711729475, 4393.033532622818, 4511.8646440606835, 4520.254158063883, 4520.841770538082, 4560.201964656172, 4571.748553829571, 4628.051249493778, 4710.764461776897, 4771.761411929459, 4791.377120974251, 4792.568668819823, 5068.695878247317, 5087.974560127176, 5103.362079740033, 5129.846104616868, 5171.095058364695, 4830.95169048305, 4859.149648811514, 4874.610031197567, 4876.634252431011, 4918.877028074184, 4835.226363781778, 4942.678725882806, 4970.378702662168, 5047.899042019212, 5105.0, 5094.388673359221, 5104.489551044866, 5109.744512774272, 5112.028714544224, 5157.045946499909, 4962.578180854668, 4966.056449274626, 4971.204607262821, 4982.701037937735, 5013.573846223112, 4901.534354236342, 4914.0908931847725, 4944.134776414041, 4967.900641987212, 4970.552650261494, 4825.300331451849, 4855.684380515255, 4866.683665561727, 4896.632752543503, 4900.558949694545, 4791.377120974251, 4974.726390048582, 4985.152524070989, 4987.975060124676, 5043.773030213576, 4849.975750121227, 4895.069936712013, 4909.803607855646, 4911.803527858846, 4920.507949205051], "value": 4615.5114599592835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6737608499028, 567.937526872044, 577.7198058941416, 580.8083332500275, 597.2027343496437, 36296.63703362965, 39693.60306396935, 39777.005574860574, 39796.0, 39865.0, 39328.80335598318, 39887.80056099715, 39921.800390998, 40003.19993600126, 40004.39993400101, 7733.458657893935, 7890.723824666138, 7892.0529536455415, 7894.960525197394, 7897.0, 7807.921920780776, 7861.8820717689, 7862.567558784264, 7869.134395216522, 7884.250996155356, 7945.602719863984, 7953.045634523836, 7954.363650907913, 7955.0, 7985.880211796828, 7845.764627061198, 7860.292573668397, 7872.212778722139, 7886.447948643598, 7913.169117242722, 7807.180246074194, 7811.1017233018365, 7836.138024817265, 7865.842683146305, 7866.292033716935, 37630.62369376299, 38090.42864357037, 38160.80919595384, 38262.23475530501, 38398.61601383978, 2952.291450051972, 2956.7486763625116, 2977.493826049577, 3150.826446280988, 3287.424700677396, 28901.710982890112, 29937.550936735966, 30055.398892022255, 30177.698223017927, 30990.225244368845, 2852.6006359109533, 2948.292409821627, 2975.538791487323, 2985.462616728988, 3018.0, 258770.0, 260719.0, 260829.0, 262052.99999999808, 263626.0, 55039.17441238384, 55767.16349254765, 55834.44165558292, 55855.720721396945, 55910.0, 32363.24912382427, 33465.16337091592, 33477.83261083679, 35480.46779298312, 35517.112072198404, 13511.121777084458, 13586.184828910296, 13621.523246686318, 13680.589582312547, 13695.452181912611, 9679.467629280458, 9716.854247186298, 9718.611255549698, 9737.707868763948, 9741.756456088655, 18197.818021819614, 18240.361587344643, 18263.269469221348, 18284.725729114074, 18327.63344733098, 6869.896951545731, 6919.9932019713715, 6928.965355173192, 6941.548799328028, 7179.605121718251, 796.8366484870587, 897.2732087009543, 923.4828496042238, 994.1847684898459, 996.8704068471052, 27073.729262707122, 27355.86322068377, 27405.62666493383, 28077.71922280751, 28098.85950570234, 865.9350548708746, 949.5157469690507, 958.8609651600478, 961.1493827962304, 1013.0, 14325.57023289303, 14578.708425831424, 14585.343659535347, 14623.78064329036, 14703.852961470462, 350156.0, 355313.0, 355526.0, 357337.0, 358182.0, 49097.75451122721, 49184.75407622939, 49475.752621237385, 49537.25694114591, 49745.0, 1179.6225207933378, 1188.4592510407917, 1189.6550000499758, 1195.1872726545857, 1198.5445530698453, 26218.344541386617, 27133.1860044199, 27215.911363546027, 27689.169324920284, 27797.16608501748, 41499.37750933799, 41878.162436750485, 41991.16017679568, 42078.0, 42089.36865947075, 324477.0, 326760.0, 327247.0, 327681.0, 328891.0, 24664.260072197863, 24833.379165521008, 25749.871250644377, 25839.483210336064, 26680.8665956669, 41491.7925410371, 41558.0, 42136.36795448132, 42166.0, 42441.575584243765, 36161.81919090493, 36174.4573831398, 37181.25637487289, 37235.49946963, 37235.81382093072, 36311.45532816957, 36823.815880920425, 36895.0, 37058.8147059263, 37700.24599508049, 32605.510917336735, 35338.46992295066, 36000.0, 36296.63703363038, 36551.817240913624, 31846.522302165024, 32886.0, 33654.49518257277, 33952.320953580296, 34044.829775850965, 25688.229353119437, 25882.48235035251, 25918.092866749572, 26012.34969125787, 26041.348966275993], "value": 17178.829736739164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.77144827379436, 377.7884384744543, 380.12950343712896, 393.52776667998376, 396.71436565672724, 16174.91912540437, 17938.37215697451, 17982.5504362391, 18744.718829217574, 18761.15574799134, 16445.753313700276, 16974.15129243536, 17248.741268880978, 17250.741238881426, 17339.306427742875, 5120.283160357553, 5260.973695131519, 5293.68237905725, 5298.311219541454, 5313.73431328434, 3823.273578020181, 5825.533957283407, 6181.0, 6193.2877719062435, 6256.562040657156, 6100.96949515254, 6210.254769427653, 6215.844603884894, 6225.8132256032395, 6236.438720515152, 6138.969305153446, 6149.754009839578, 6149.815505534841, 6185.505159587245, 6189.9381006189815, 5255.76349064293, 5405.297311349539, 5483.314585676791, 5485.588580856412, 5507.779688812443, 20832.27087051946, 21065.157393704234, 21349.146034158613, 21491.355259342246, 21495.0, 1769.0447158534375, 1805.9796215138406, 1830.4600142957859, 2106.8630539014916, 2211.7456492503406, 13545.52590659332, 13663.316834158253, 13674.31628418575, 13842.515511957034, 13861.168329900238, 1681.6468541606278, 1708.6924353616344, 1731.3247833345006, 1743.320105158989, 1792.5339411752907, 70255.29744702538, 72999.63500182464, 73081.6345918267, 73748.63125684338, 74427.0, 9025.954870225607, 9029.23251523628, 9365.438073715599, 9588.185004274716, 9595.616175353047, 12937.0, 13002.0, 13002.674933126558, 13046.478140874258, 13050.477980880849, 7153.4992550520965, 7213.963930180315, 7298.4891057625455, 7395.519291246052, 7444.516106453063, 7032.437405007587, 7116.217216106224, 7127.857442851114, 7189.856202876018, 7264.237255088246, 5425.647332923348, 6012.398760123952, 6020.969895150496, 6059.121427393004, 6106.267247930276, 1612.5726682429165, 1737.860971122307, 1787.3922866225287, 1794.120880768414, 1844.1424737497127, 823.1439303124683, 854.5641722721333, 864.0409145848104, 869.7912500999714, 960.274992380748, 17055.317787288368, 17213.31146754116, 17807.821921780618, 18014.729779053323, 18026.36907708224, 841.3479553346083, 845.0788640382013, 879.046234835211, 894.8612964990436, 956.5121787888227, 10036.447995360179, 10248.180145588483, 10255.487225638688, 10283.331583447052, 10333.844992325121, 329898.0, 331006.0, 331934.0, 346780.0, 363366.0, 40750.388744168864, 48358.758206208746, 68835.31164688389, 73876.63061684657, 75540.62229688927, 839.6053854688287, 879.6657270237397, 880.8370451466499, 887.6538150121457, 894.7852515396388, 15965.840341596435, 16143.919280403523, 16401.261943212823, 16469.752953705465, 16938.068406237777, 38954.4156837642, 39779.60220397759, 41241.0, 41874.581254188284, 42137.36793948032, 47792.522074778804, 47813.04373912572, 48090.27864582104, 49496.75251623719, 50648.24027639515, 7265.564066156047, 7271.127464704269, 7412.96293518529, 7494.288042635941, 7573.091229052549, 10857.891421085687, 10876.836847447454, 11168.0, 11480.655580332603, 11583.247088939192, 9462.57418416159, 9465.337426380363, 9484.905150948678, 9724.854127188239, 9932.404055756677, 9654.662086826927, 9725.416475011521, 9765.267604929517, 9835.803283934138, 9843.557039933077, 9440.527973601429, 9617.374870633386, 9628.18160456341, 9800.215982721507, 10042.598296068367, 6144.2319710036245, 6152.230971128609, 6247.625142491465, 6347.96826015867, 6404.391582799627, 9174.816503669756, 9193.77015574616, 9214.078592141, 9548.665796697082, 9617.855732163884], "value": 8308.146844867175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.1361648969394, 1413.590058882924, 1505.4806091898292, 1681.3442757324653, 1712.7773389459376, 6750.864982700343, 7514.887276690854, 7885.84228315434, 8204.876926846102, 8260.71087511938, 7898.328642065417, 7910.090339610946, 7982.680692772296, 7992.640331185096, 8004.159563245863, 2221.4113259986075, 2273.1134857405623, 2282.0, 2283.9657405138855, 2284.3832165315357, 2136.9893150534226, 2164.2641501889357, 2234.26844195748, 2249.167807911075, 2258.9209377671787, 2157.967630485544, 2164.9025793839314, 2178.6078505868936, 2181.454636340915, 2187.7593464718866, 2174.239016344267, 2184.1154332495366, 2188.4528867783056, 2201.6587428948537, 2209.5912256232486, 2122.904469298885, 2143.9464013399634, 2145.495808485005, 2148.4199266198193, 2154.7306586676664, 8017.398695097891, 8026.478278911911, 8045.919540804575, 8064.8387032259025, 8089.352851771903, 4517.186906356855, 4611.077784443125, 4690.061987602493, 4693.20215563355, 4700.1539722849875, 2641.168032069892, 2716.456708658276, 2751.284665986858, 2776.625155603988, 2824.9435011299865, 839.9496030238145, 854.9358798090168, 860.0496451421152, 871.3116637856086, 888.7111688701198, 10890.61882834097, 10901.509432075654, 10939.234253602252, 10958.178136639784, 10960.12319014477, 4154.480689913761, 4193.601607847249, 4364.8472303469225, 4366.3013917773005, 4381.2989921613025, 9331.206847418045, 9333.0, 9387.5306234688, 9393.060693930689, 9417.293702972305, 4712.387389639325, 4718.834840780556, 4723.645726570452, 4725.3384526166365, 4728.787204575802, 3581.28374325136, 4108.157827645326, 4224.239636865394, 4259.723117997382, 4266.317389217772, 3722.3113723961155, 3779.60314167014, 3814.713896457721, 3856.7107466940092, 3917.5886531914307, 1187.54279602352, 1210.0501106631252, 1217.1054275107788, 1219.116140797932, 1222.7798996180773, 811.6063709101081, 816.4121832280748, 842.2335674536142, 847.9830403391898, 852.7910661887877, 5144.202648589475, 5237.450067742909, 5301.54936830366, 5380.192971054373, 5407.242985981966, 412.0810592378952, 417.764957477493, 421.62686022869366, 427.95934386233256, 429.7657776511809, 3555.928881422357, 3743.3449146399817, 3762.492063571383, 3791.1659434924272, 3852.730308878408, 9509.0, 9816.901830981742, 9827.754306142404, 9866.80266394668, 9911.306208565331, 9613.0, 9785.902140978498, 9806.65676701312, 9809.411435313905, 9827.0, 7440.553566785902, 7474.850502990019, 7502.062242219723, 7528.924710752932, 7549.471536992358, 5150.8969820604125, 5304.336957880265, 5403.756830942539, 5448.0465918463315, 5482.2873026506295, 8825.867611985697, 8987.55062246872, 9176.311776616647, 9185.724428267162, 9212.401193922373, 9146.176844084064, 9195.86206206894, 9225.446473211361, 9233.676821311223, 9307.06929307064, 6197.163382943245, 6286.748530058747, 6558.573692709959, 6883.208431030495, 6936.4797640176175, 7689.6539655714505, 7698.153203147761, 7708.152103268524, 7737.381009519338, 7741.845163096819, 6796.0, 6998.580085194904, 7000.719971201095, 7051.788446346618, 7112.928870711226, 6778.389944904982, 6840.31596840312, 6870.381665650116, 6915.827104322432, 6947.478939079489, 6503.666748316678, 6535.44448721864, 6566.507511936528, 6577.539572229898, 6587.077809106633, 4540.0, 4583.495815460364, 4614.353990441274, 4669.813207471799, 4767.237242041257, 4577.3591697161755, 4602.723836569817, 4605.953940460552, 4608.746518941491, 4740.668153229379], "value": 4113.632738743487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.9601803756492, 301.4573767219005, 309.37814991866355, 311.9079871437926, 313.70355014511296, 4853.927191092128, 4947.307376967227, 5040.117979353612, 5082.6365739930925, 5101.081805275054, 4979.502049795019, 4989.975050124754, 4996.675216110959, 5009.048280826641, 5034.375249820124, 3944.23087497938, 3954.3787047310607, 3968.464257325253, 3970.960290397102, 3978.8010599470053, 3861.1891502784447, 3926.4895563576697, 3935.3703407454814, 3948.723589348747, 3951.861684841031, 3915.1386694927214, 3932.1742434088733, 3934.567197608261, 3947.9210415791667, 3948.5853985331414, 3931.429942658313, 3939.606039396066, 3943.960560394388, 3944.5996671181606, 3952.332175781336, 3477.9652203477895, 3485.268093700326, 3487.686108250244, 3493.510908472816, 3496.965030349689, 4617.515160908123, 4944.307796908436, 4950.851474455736, 4965.925511117336, 4969.676970996909, 4435.534268901751, 4439.600435960779, 4452.643788496913, 4468.151051300242, 4472.418585583886, 5281.735913204363, 5294.814681486129, 5302.787888484456, 5303.7348132593215, 5309.283246761676, 3614.0, 3717.70258379329, 3724.925501489955, 3728.738988270822, 3749.5376803046834, 5523.392426833045, 5539.695316757577, 5556.583256255756, 5568.693721845257, 5570.192322113271, 3733.3466643337306, 3747.306748251582, 3748.475213470116, 3766.4915236443276, 3771.189194323179, 3737.6075512071384, 3807.9809600951817, 3813.866514671973, 3814.4469051987307, 3830.693544516432, 4348.652107831366, 4406.955930440655, 4408.823647054082, 4421.845235416745, 4442.8667139985855, 5268.631195816256, 5286.7092309922555, 5293.338332708411, 5293.417724050351, 5304.336957880265, 1252.991341969705, 1286.9254172765845, 1316.414195682912, 1324.5364122557028, 1325.734853029398, 879.4591326334258, 887.4985633117398, 888.8666699994923, 901.9942763818426, 907.4827348411474, 4579.358889755437, 4599.9080018399445, 4612.331211974312, 4614.146382919171, 4618.261078227468, 5331.413544510101, 5340.49265319794, 5347.385050719217, 5407.864803379868, 5412.107002344648, 4414.624756895636, 4598.471175814757, 4604.677672562889, 4617.815287388534, 4633.911030907734, 2521.571332873416, 2551.0, 2554.5657238269537, 2556.6037264224074, 2561.5261176682375, 4498.730076195438, 4520.344550040226, 4566.771661416916, 4592.242280023758, 4599.5400459953735, 4657.580817726421, 4863.027394521039, 4866.586340161126, 4884.438289596671, 4886.682365646293, 4481.910361792746, 4488.765589462859, 4527.343535187445, 4530.343100250511, 4551.0, 4705.7647117644665, 4762.951710905093, 4772.642051846056, 4791.616670666408, 4819.903601928012, 4526.796294166705, 4690.9765451172525, 4692.976535117303, 4703.647226458098, 4733.0, 4441.422615060022, 4532.0256144929, 4539.568740969603, 4543.547323622802, 4557.589816916494, 3433.570803649544, 3450.6549345066296, 3464.514967904445, 3469.6183419824306, 3475.913102172466, 4757.524247575215, 4773.832915847928, 4779.737114458599, 4781.9043619128115, 5121.206213036985, 5038.697678139323, 5279.260903473593, 5279.762410691451, 5284.630075894651, 5299.39057008449, 5260.763265652979, 5284.603654725988, 5298.549623282064, 5303.15149576066, 5310.8937821244135, 4958.578520825626, 5184.559312458483, 5195.480451954774, 5235.712035838065, 5255.421903590678, 5361.892762144813, 5371.435999220182, 5378.73106344689, 5391.676499410048, 5402.972985135049, 5256.579473642023, 5259.184826351921, 5269.1832765921345, 5291.068759902685, 5301.469853014668], "value": 3847.686485482981, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3476658292586, 598.8023952095809, 601.7352364959418, 626.6334194496219, 676.5399528320743, 12474.126811123213, 13639.181649101036, 13765.518206862762, 13795.103318284304, 13801.585952421417, 12869.0, 13311.534096306632, 13561.660958476043, 13608.52370167042, 13612.863871361284, 765.1850778920445, 784.3058892879785, 788.3377962511489, 788.4047544104193, 790.020374735327, 791.9762407127795, 797.8603744344746, 798.8562058829408, 798.8641930871765, 799.3525244551903, 836.9455985360962, 838.786109542069, 839.3201506779498, 840.9873851892227, 844.2275318083946, 822.9177082291753, 828.668532586967, 829.1087081387473, 829.274384913201, 831.1605278668528, 610.5298919831705, 612.9141920131185, 613.098744845077, 614.7448808744366, 614.9631022138641, 11923.821142682868, 12037.699057523545, 12097.57658481949, 12112.031037517065, 12113.576024839176, 9787.90212097877, 9812.125117731608, 9815.0, 10069.69790906274, 10260.897391026143, 8834.160754728355, 9022.593983270768, 9075.18323350895, 9173.58718857653, 9261.72214833556, 3193.457112290916, 3241.6920392562906, 3258.6415494295607, 3269.8365081746056, 3285.737141028712, 58683.706581467246, 61207.38792612106, 61318.080228796156, 62087.37912620906, 62235.066474002924, 7584.54492730438, 7657.157712651604, 7721.0, 7725.343345815556, 7733.535987840747, 16634.417795377103, 17555.912220438815, 17567.73648395275, 17595.384161554284, 17627.206775695126, 6690.029945657852, 6754.358335958076, 6791.898121528181, 6855.897161542581, 6937.375636192767, 3476.1657202271776, 3477.426224672901, 3499.807510586891, 3508.6842184203542, 3712.6658600726064, 2842.4030953499996, 2944.4258369618146, 2961.6742158362563, 2965.9703402966124, 2969.985150074279, 465.5600457567566, 481.93250953410177, 482.6356101143614, 486.6107114308539, 497.437895178446, 497.5397757074691, 504.7097918696764, 510.54306395775575, 521.5228066319276, 524.2346174585073, 7191.532550384209, 7306.305900939402, 7433.962830185923, 7445.441591880631, 7477.738279160203, 364.3041790180742, 425.9957400426018, 428.7534667566162, 488.8069212660979, 508.7786812736471, 3300.966990330066, 3436.467347561132, 3534.5581802274714, 3602.7297952653657, 3705.221903400316, 68928.31071689219, 91631.08368916226, 95561.0, 97320.0, 98599.0, 45789.77105114453, 54706.179407308126, 79221.20778792254, 80634.0, 84683.0, 75707.62146189345, 75821.0, 76230.23769762342, 77037.6148119267, 77124.22875771283, 6217.316095229611, 6271.122042914087, 6608.70260838273, 6765.154355705537, 6883.965580172067, 34108.0, 35094.649053509136, 39475.60524394834, 44410.777946110065, 44954.0, 63757.362426376996, 64828.43443610458, 64941.35058649542, 65157.34842651703, 65513.67243163945, 8101.189881011852, 8246.0, 8374.916250837414, 8460.238578527962, 8539.103394143774, 9299.628014879328, 9307.627694892128, 9448.95275523618, 11856.644300670994, 12049.638510844688, 10873.401962892116, 10895.891041089488, 11281.43592820372, 11567.190296679151, 11893.0, 11103.555857765921, 11501.769964600828, 11625.418729063682, 11634.70913227176, 12168.695782605151, 10526.263161578616, 10782.406967616856, 11113.388763617755, 11492.94253528727, 11527.423628818693, 9390.295727820305, 9440.763980900532, 9459.905400945903, 9510.334276600572, 9599.712008639752, 8704.26013788835, 8735.519546425008, 8930.374873759034, 9120.817583648422, 9426.010268921938], "value": 6063.257597478158, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 110.0, 115.0, 116.0, 116.0, 117.0, 115.0, 115.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 150.0, 184.0, 125.0, 153.0, 148.0, 127.0, 179.0, 128.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 165.0, 168.0, 164.0, 163.0, 164.0, 163.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 158.0, 79.0, 77.0, 77.0, 74.0, 160.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 140.0, 86.0, 87.0, 85.0, 147.0, 86.0, 86.0, 145.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 123.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 151.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 68.0, 67.0, 68.0, 66.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 67.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 80.0, 80.0, 83.0, 86.0, 79.0, 86.0, 86.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 132.0, 138.0, 132.0, 137.0, 135.0, 134.0, 170.0, 143.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 166.0, 169.0, 165.0, 165.0, 166.0, 167.0, 166.0, 171.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 66.0, 68.0, 66.0, 66.0, 70.0, 66.0, 65.0, 66.0], "value": 67.2, "unit": "score"}]}]} 15:25:46 INFO - Return code: 0 15:25:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:25:46 ERROR - # TBPL SUCCESS # 15:25:46 INFO - Running post-action listener: _resource_record_post_action 15:25:46 INFO - ##### 15:25:46 INFO - ##### Finished run-tests step (success) 15:25:46 INFO - ##### 15:25:46 INFO - Running post-run listener: _resource_record_post_run 15:25:46 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540442624; Read time: 12; Write time: 460856 15:25:46 INFO - TinderboxPrint: CPU usage
13.4% 15:25:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:25:46 INFO - TinderboxPrint: I/O write bytes / time
540,442,624 / 460,856 15:25:46 INFO - TinderboxPrint: CPU idle
8,280.3 (86.6%) 15:25:46 INFO - TinderboxPrint: CPU user
1,222.1 (12.8%) 15:25:46 INFO - TinderboxPrint: Swap in / out
0 / 0 15:25:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250929152; Read time: 0; Write time: 273712 15:25:46 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289513472; Read time: 0; Write time: 187144 15:25:47 INFO - Running post-run listener: _upload_blobber_files 15:25:47 INFO - Blob upload gear active. 15:25:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:25:47 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 15:25:47 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'] 15:25:47 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 15:25:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:48 INFO - (blobuploader) - INFO - Done attempting. 15:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:48 INFO - (blobuploader) - INFO - Done attempting. 15:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:53 INFO - (blobuploader) - INFO - Done attempting. 15:25:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:25:53 INFO - Return code: 0 15:25:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:25:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:25:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a1cc1db39b9ff164f6e52faa989ce0758a1103b875d517a6560e2468d9046471b0f1b8939bcec702240a88ccdd536cdf0a85d104ecd068a3581caa1b5caccc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e8744965ad9669b7d34e65dc024ee00dd9620518798bd6eeaad6a39778cb7cf9e34fd7638c2822dba0818284e923ac2c1c194dbc176283cddd7f129b0247629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e9f50b1599348b73a98769b42cdbfb82d2f81a8a1778bd02f97b03a9e9723e3dfd401e58769d995b0c2b01340e72206d006f8a39e2c49891de722b2234fb94e"} 15:25:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:25:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:25:53 INFO - Contents: 15:25:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a1cc1db39b9ff164f6e52faa989ce0758a1103b875d517a6560e2468d9046471b0f1b8939bcec702240a88ccdd536cdf0a85d104ecd068a3581caa1b5caccc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e8744965ad9669b7d34e65dc024ee00dd9620518798bd6eeaad6a39778cb7cf9e34fd7638c2822dba0818284e923ac2c1c194dbc176283cddd7f129b0247629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e9f50b1599348b73a98769b42cdbfb82d2f81a8a1778bd02f97b03a9e9723e3dfd401e58769d995b0c2b01340e72206d006f8a39e2c49891de722b2234fb94e"} 15:25:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:25:53 INFO - Copying logs to upload dir... 15:25:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:25:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.360608 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-13 15:25:53.788668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:25:53.792000) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a1cc1db39b9ff164f6e52faa989ce0758a1103b875d517a6560e2468d9046471b0f1b8939bcec702240a88ccdd536cdf0a85d104ecd068a3581caa1b5caccc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e8744965ad9669b7d34e65dc024ee00dd9620518798bd6eeaad6a39778cb7cf9e34fd7638c2822dba0818284e923ac2c1c194dbc176283cddd7f129b0247629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e9f50b1599348b73a98769b42cdbfb82d2f81a8a1778bd02f97b03a9e9723e3dfd401e58769d995b0c2b01340e72206d006f8a39e2c49891de722b2234fb94e"} build_url:https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/I5-Hs1eIRYubQUHtdTjAZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a1cc1db39b9ff164f6e52faa989ce0758a1103b875d517a6560e2468d9046471b0f1b8939bcec702240a88ccdd536cdf0a85d104ecd068a3581caa1b5caccc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e8744965ad9669b7d34e65dc024ee00dd9620518798bd6eeaad6a39778cb7cf9e34fd7638c2822dba0818284e923ac2c1c194dbc176283cddd7f129b0247629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e9f50b1599348b73a98769b42cdbfb82d2f81a8a1778bd02f97b03a9e9723e3dfd401e58769d995b0c2b01340e72206d006f8a39e2c49891de722b2234fb94e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:25:53.817705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:25:53.818050) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468447514.419535-2015184864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:25:53.902412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:25:53.902875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:25:53.903297) ========= ========= Total master_lag: 0.17 =========