builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1468919519.21 results: success (0) buildid: 20160719013221 builduid: 315c166eeb824724a024926cd92f5dfd revision: 65524ee7219ac01b54b89836b67d70ea9d818dbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.213989) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.214533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.214902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.231058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.231454) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 02:11:59-- 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% 226M=0s 2016-07-19 02:11:59 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092187 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.338681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.339092) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015446 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.389737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:11:59.390194) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 65524ee7219ac01b54b89836b67d70ea9d818dbc --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 65524ee7219ac01b54b89836b67d70ea9d818dbc --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=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 02:11:59,803 truncating revision to first 12 chars 2016-07-19 02:11:59,803 Setting DEBUG logging. 2016-07-19 02:11:59,803 attempt 1/10 2016-07-19 02:11:59,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/65524ee7219a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 02:12:00,164 unpacking tar archive at: fx-team-65524ee7219a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:12:00.122575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:12:00.122977) ========= script_repo_revision: 65524ee7219ac01b54b89836b67d70ea9d818dbc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:12:00.123489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:12:00.123844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:12:00.137082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-19 02:12:00.137579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:00 INFO - MultiFileLogger online at 20160719 02:12:00 in /builds/slave/test 02:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:00 INFO - {'append_to_log': False, 02:12:00 INFO - 'base_work_dir': '/builds/slave/test', 02:12:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:00 INFO - 'branch': 'Fx-Team-Non-PGO', 02:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:00 INFO - 'config_files': ('talos/linux_config.py',), 02:12:00 INFO - 'default_actions': ('clobber', 02:12:00 INFO - 'read-buildbot-config', 02:12:00 INFO - 'download-and-extract', 02:12:00 INFO - 'populate-webroot', 02:12:00 INFO - 'create-virtualenv', 02:12:00 INFO - 'install', 02:12:00 INFO - 'run-tests'), 02:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:00 INFO - 'download_minidump_stackwalk': True, 02:12:00 INFO - 'download_symbols': 'ondemand', 02:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:00 INFO - 'installer_path': 'installer.exe', 02:12:00 INFO - 'log_level': 'info', 02:12:00 INFO - 'log_name': 'talos', 02:12:00 INFO - 'log_to_console': True, 02:12:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:00 INFO - 'opt_config_files': (), 02:12:00 INFO - 'pip_index': False, 02:12:00 INFO - 'sps_profile': False, 02:12:00 INFO - 'sps_profile_interval': 0, 02:12:00 INFO - 'suite': 'dromaeojs', 02:12:00 INFO - 'system_bits': '32', 02:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:00 INFO - 'title': 'talos-linux64-ix-067', 02:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:00 INFO - 'use_talos_json': True, 02:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:00 INFO - 'work_dir': 'build'} 02:12:00 INFO - ##### 02:12:00 INFO - ##### Running clobber step. 02:12:00 INFO - ##### 02:12:00 INFO - Running pre-action listener: _resource_record_pre_action 02:12:00 INFO - Running main action method: clobber 02:12:00 INFO - rmtree: /builds/slave/test/build 02:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:01 INFO - Running post-action listener: _resource_record_post_action 02:12:01 INFO - ##### 02:12:01 INFO - ##### Finished clobber step (success) 02:12:01 INFO - ##### 02:12:01 INFO - ##### 02:12:01 INFO - ##### Running read-buildbot-config step. 02:12:01 INFO - ##### 02:12:01 INFO - Running pre-action listener: _resource_record_pre_action 02:12:01 INFO - Running main action method: read_buildbot_config 02:12:01 INFO - Using buildbot properties: 02:12:01 INFO - { 02:12:01 INFO - "project": "", 02:12:01 INFO - "product": "firefox", 02:12:01 INFO - "script_repo_revision": "production", 02:12:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:12:01 INFO - "repository": "", 02:12:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:12:01 INFO - "buildid": "20160719013221", 02:12:01 INFO - "pgo_build": "False", 02:12:01 INFO - "basedir": "/builds/slave/test", 02:12:01 INFO - "buildnumber": 3176, 02:12:01 INFO - "slavename": "talos-linux64-ix-067", 02:12:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:12:01 INFO - "platform": "ubuntu64_hw", 02:12:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:12:01 INFO - "branch": "fx-team", 02:12:01 INFO - "repo_path": "integration/fx-team", 02:12:01 INFO - "revision": "65524ee7219ac01b54b89836b67d70ea9d818dbc", 02:12:01 INFO - "stage_platform": "linux64", 02:12:01 INFO - "builduid": "315c166eeb824724a024926cd92f5dfd", 02:12:01 INFO - "slavebuilddir": "test" 02:12:01 INFO - } 02:12:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:12:01 INFO - Running post-action listener: _resource_record_post_action 02:12:01 INFO - ##### 02:12:01 INFO - ##### Finished read-buildbot-config step (success) 02:12:01 INFO - ##### 02:12:01 INFO - ##### 02:12:01 INFO - ##### Running download-and-extract step. 02:12:01 INFO - ##### 02:12:01 INFO - Running pre-action listener: _resource_record_pre_action 02:12:01 INFO - Running main action method: download_and_extract 02:12:01 INFO - mkdir: /builds/slave/test/build/tests 02:12:01 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')]} 02:12:01 INFO - https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:01 INFO - Downloaded 1361 bytes. 02:12:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:01 INFO - Using the following test package requirements: 02:12:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:12:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'jsshell-linux-x86_64.zip'], 02:12:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:01 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')]} 02:12:01 INFO - https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:04 INFO - Downloaded 22763363 bytes. 02:12:04 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'] 02:12:04 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 02:12:06 INFO - Return code: 0 02:12:06 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 02:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:06 INFO - https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:20 INFO - Downloaded 22763363 bytes. 02:12:20 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'] 02:12:20 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 02:12:21 INFO - Return code: 0 02:12:21 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')]} 02:12:21 INFO - https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:22 INFO - Downloaded 14403317 bytes. 02:12:22 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'] 02:12:22 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 02:12:22 INFO - Return code: 0 02:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:22 INFO - https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NRZj8GBLQA6o_wTGaTM6SA/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 02:12:24 INFO - Downloaded 57129315 bytes. 02:12:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:24 INFO - mkdir: /builds/slave/test/properties 02:12:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:12:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:12:24 INFO - Contents: 02:12:24 INFO - build_url:https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:24 INFO - Running post-action listener: _resource_record_post_action 02:12:24 INFO - Running post-action listener: set_extra_try_arguments 02:12:24 INFO - ##### 02:12:24 INFO - ##### Finished download-and-extract step (success) 02:12:24 INFO - ##### 02:12:24 INFO - ##### 02:12:24 INFO - ##### Running populate-webroot step. 02:12:24 INFO - ##### 02:12:24 INFO - Running pre-action listener: _resource_record_pre_action 02:12:24 INFO - Running main action method: populate_webroot 02:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:12:24 INFO - '--tppagecycles', 02:12:24 INFO - '7'], 02:12:24 INFO - 'tests': ['tsvgm']}}, 02:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:12:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['damp', 'tps']}, 02:12:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'tests': ['damp', 'tps']}, 02:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['dromaeo_dom']}, 02:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['basic_compositor_video']}, 02:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['a11yr', 02:12:24 INFO - 'ts_paint', 02:12:24 INFO - 'tpaint', 02:12:24 INFO - 'sessionrestore', 02:12:24 INFO - 'sessionrestore_no_auto_restore', 02:12:24 INFO - 'tabpaint']}, 02:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['tsvgx', 02:12:24 INFO - 'tsvgr_opacity', 02:12:24 INFO - 'tart', 02:12:24 INFO - 'tscrollx', 02:12:24 INFO - 'cart']}, 02:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:12:24 INFO - 'tsvgr_opacity', 02:12:24 INFO - 'tart', 02:12:24 INFO - 'tscrollx', 02:12:24 INFO - 'cart']}, 02:12:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'talos_options': ['--disable-e10s'], 02:12:24 INFO - 'tests': ['tp5o']}, 02:12:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'tests': ['tp5o']}, 02:12:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'talos_options': ['--disable-e10s', 02:12:24 INFO - '--xperf_path', 02:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:24 INFO - 'tests': ['tp5n']}, 02:12:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:24 INFO - 'talos_options': ['--xperf_path', 02:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:24 INFO - 'tests': ['tp5n']}}, 02:12:24 INFO - 'talos.zip': {'path': '', 02:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:12:24 INFO - Running post-action listener: _resource_record_post_action 02:12:24 INFO - ##### 02:12:24 INFO - ##### Finished populate-webroot step (success) 02:12:24 INFO - ##### 02:12:24 INFO - ##### 02:12:24 INFO - ##### Running create-virtualenv step. 02:12:24 INFO - ##### 02:12:24 INFO - Running pre-action listener: _resource_record_pre_action 02:12:24 INFO - Running main action method: create_virtualenv 02:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:12:24 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 02:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:12:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:12:25 INFO - Using real prefix '/usr' 02:12:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:27 INFO - Installing pip.................done. 02:12:27 INFO - Return code: 0 02:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12:27 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')]} 02:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:27 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')]} 02:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:27 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:27 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 02:12:27 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 02:12:27 INFO - Using env: {'DISPLAY': ':0', 02:12:27 INFO - 'HOME': '/home/cltbld', 02:12:27 INFO - 'LANG': 'en_US.UTF-8', 02:12:27 INFO - 'LANGUAGE': 'en_US:en', 02:12:27 INFO - 'LOGNAME': 'cltbld', 02:12:27 INFO - 'MAIL': '/var/mail/cltbld', 02:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:27 INFO - 'MOZ_NO_REMOTE': '1', 02:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:27 INFO - 'NO_EM_RESTART': '1', 02:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:27 INFO - 'PWD': '/builds/slave/test', 02:12:27 INFO - 'SHELL': '/bin/bash', 02:12:27 INFO - 'SHLVL': '1', 02:12:27 INFO - 'TERM': 'linux', 02:12:27 INFO - 'TMOUT': '86400', 02:12:27 INFO - 'USER': 'cltbld', 02:12:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:27 INFO - '_': '/tools/buildbot/bin/python'} 02:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:27 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 02:12:27 INFO - Cleaning up... 02:12:27 INFO - Return code: 0 02:12:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:12:27 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')]} 02:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:27 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')]} 02:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:27 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:27 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 02:12:27 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 02:12:27 INFO - Using env: {'DISPLAY': ':0', 02:12:27 INFO - 'HOME': '/home/cltbld', 02:12:27 INFO - 'LANG': 'en_US.UTF-8', 02:12:27 INFO - 'LANGUAGE': 'en_US:en', 02:12:27 INFO - 'LOGNAME': 'cltbld', 02:12:27 INFO - 'MAIL': '/var/mail/cltbld', 02:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:27 INFO - 'MOZ_NO_REMOTE': '1', 02:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:27 INFO - 'NO_EM_RESTART': '1', 02:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:27 INFO - 'PWD': '/builds/slave/test', 02:12:27 INFO - 'SHELL': '/bin/bash', 02:12:27 INFO - 'SHLVL': '1', 02:12:27 INFO - 'TERM': 'linux', 02:12:27 INFO - 'TMOUT': '86400', 02:12:27 INFO - 'USER': 'cltbld', 02:12:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:27 INFO - '_': '/tools/buildbot/bin/python'} 02:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:27 INFO - Downloading/unpacking psutil>=3.1.1 02:12:27 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 02:12:27 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 02:12:27 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 02:12:27 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 02:12:27 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 02:12:27 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 02:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:29 INFO - Installing collected packages: psutil 02:12:29 INFO - Running setup.py install for psutil 02:12:29 INFO - building 'psutil._psutil_linux' extension 02:12:29 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 02:12:29 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 02:12:29 INFO - building 'psutil._psutil_posix' extension 02:12:29 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 02:12:29 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 02:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:30 INFO - Successfully installed psutil 02:12:30 INFO - Cleaning up... 02:12:30 INFO - Return code: 0 02:12:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:12:30 INFO - Using env: {'DISPLAY': ':0', 02:12:30 INFO - 'HOME': '/home/cltbld', 02:12:30 INFO - 'LANG': 'en_US.UTF-8', 02:12:30 INFO - 'LANGUAGE': 'en_US:en', 02:12:30 INFO - 'LOGNAME': 'cltbld', 02:12:30 INFO - 'MAIL': '/var/mail/cltbld', 02:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:30 INFO - 'MOZ_NO_REMOTE': '1', 02:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:30 INFO - 'NO_EM_RESTART': '1', 02:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:30 INFO - 'PWD': '/builds/slave/test', 02:12:30 INFO - 'SHELL': '/bin/bash', 02:12:30 INFO - 'SHLVL': '1', 02:12:30 INFO - 'TERM': 'linux', 02:12:30 INFO - 'TMOUT': '86400', 02:12:30 INFO - 'USER': 'cltbld', 02:12:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:30 INFO - '_': '/tools/buildbot/bin/python'} 02:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:12:32 INFO - Installing collected packages: mozsystemmonitor 02:12:32 INFO - Running setup.py install for mozsystemmonitor 02:12:32 INFO - Successfully installed mozsystemmonitor 02:12:32 INFO - Cleaning up... 02:12:32 INFO - Return code: 0 02:12:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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', '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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:12: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 jsonschema==2.5.1 02:12:32 INFO - Using env: {'DISPLAY': ':0', 02:12:32 INFO - 'HOME': '/home/cltbld', 02:12:32 INFO - 'LANG': 'en_US.UTF-8', 02:12:32 INFO - 'LANGUAGE': 'en_US:en', 02:12:32 INFO - 'LOGNAME': 'cltbld', 02:12:32 INFO - 'MAIL': '/var/mail/cltbld', 02:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:32 INFO - 'MOZ_NO_REMOTE': '1', 02:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:32 INFO - 'NO_EM_RESTART': '1', 02:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:32 INFO - 'PWD': '/builds/slave/test', 02:12:32 INFO - 'SHELL': '/bin/bash', 02:12:32 INFO - 'SHLVL': '1', 02:12:32 INFO - 'TERM': 'linux', 02:12:32 INFO - 'TMOUT': '86400', 02:12:32 INFO - 'USER': 'cltbld', 02:12:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:32 INFO - '_': '/tools/buildbot/bin/python'} 02:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:34 INFO - warning: no files found matching '*.txt' 02:12:34 INFO - no previously-included directories found matching 'build' 02:12:34 INFO - no previously-included directories found matching 'dist' 02:12:34 INFO - no previously-included directories found matching '.git*' 02:12:34 INFO - Installing collected packages: jsonschema, functools32 02:12:34 INFO - Running setup.py install for functools32 02:12:34 INFO - warning: no files found matching '*.txt' 02:12:34 INFO - no previously-included directories found matching 'build' 02:12:34 INFO - no previously-included directories found matching 'dist' 02:12:34 INFO - no previously-included directories found matching '.git*' 02:12:34 INFO - Successfully installed jsonschema functools32 02:12:34 INFO - Cleaning up... 02:12:34 INFO - Return code: 0 02:12:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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', '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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:12: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 blobuploader==1.2.4 02:12:34 INFO - Using env: {'DISPLAY': ':0', 02:12:34 INFO - 'HOME': '/home/cltbld', 02:12:34 INFO - 'LANG': 'en_US.UTF-8', 02:12:34 INFO - 'LANGUAGE': 'en_US:en', 02:12:34 INFO - 'LOGNAME': 'cltbld', 02:12:34 INFO - 'MAIL': '/var/mail/cltbld', 02:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:34 INFO - 'MOZ_NO_REMOTE': '1', 02:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:34 INFO - 'NO_EM_RESTART': '1', 02:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:34 INFO - 'PWD': '/builds/slave/test', 02:12:34 INFO - 'SHELL': '/bin/bash', 02:12:34 INFO - 'SHLVL': '1', 02:12:34 INFO - 'TERM': 'linux', 02:12:34 INFO - 'TMOUT': '86400', 02:12:34 INFO - 'USER': 'cltbld', 02:12:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:34 INFO - '_': '/tools/buildbot/bin/python'} 02:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:37 INFO - Downloading docopt-0.6.1.tar.gz 02:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:37 INFO - Running setup.py install for blobuploader 02:12:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:37 INFO - Running setup.py install for requests 02:12:38 INFO - Running setup.py install for docopt 02:12:38 INFO - Successfully installed blobuploader requests docopt 02:12:38 INFO - Cleaning up... 02:12:38 INFO - Return code: 0 02:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:38 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')]} 02:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:38 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')]} 02:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:38 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:38 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 02:12:38 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 02:12:38 INFO - Using env: {'DISPLAY': ':0', 02:12:38 INFO - 'HOME': '/home/cltbld', 02:12:38 INFO - 'LANG': 'en_US.UTF-8', 02:12:38 INFO - 'LANGUAGE': 'en_US:en', 02:12:38 INFO - 'LOGNAME': 'cltbld', 02:12:38 INFO - 'MAIL': '/var/mail/cltbld', 02:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:38 INFO - 'MOZ_NO_REMOTE': '1', 02:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:38 INFO - 'NO_EM_RESTART': '1', 02:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:38 INFO - 'PWD': '/builds/slave/test', 02:12:38 INFO - 'SHELL': '/bin/bash', 02:12:38 INFO - 'SHLVL': '1', 02:12:38 INFO - 'TERM': 'linux', 02:12:38 INFO - 'TMOUT': '86400', 02:12:38 INFO - 'USER': 'cltbld', 02:12:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:38 INFO - '_': '/tools/buildbot/bin/python'} 02:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:38 INFO - Running setup.py (path:/tmp/pip-v5ooOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:38 INFO - Running setup.py (path:/tmp/pip-trARKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:38 INFO - Running setup.py (path:/tmp/pip-m9aKQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:38 INFO - Running setup.py (path:/tmp/pip-GVhuPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:39 INFO - Running setup.py (path:/tmp/pip-t4RNMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:39 INFO - Running setup.py (path:/tmp/pip-BojTmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:39 INFO - Running setup.py (path:/tmp/pip-HmKoA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:39 INFO - Running setup.py (path:/tmp/pip-th420d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:39 INFO - Running setup.py (path:/tmp/pip-EtyECF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:39 INFO - Running setup.py (path:/tmp/pip-vkeGfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:39 INFO - Running setup.py (path:/tmp/pip-6vTQvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:39 INFO - Running setup.py (path:/tmp/pip-dpmqCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:39 INFO - Running setup.py (path:/tmp/pip-G5Pvhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:39 INFO - Running setup.py (path:/tmp/pip-isRjNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:39 INFO - Running setup.py (path:/tmp/pip-HbTJiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:39 INFO - Running setup.py (path:/tmp/pip-ANxUuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:39 INFO - Running setup.py (path:/tmp/pip-gAxew1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:39 INFO - Running setup.py install for manifestparser 02:12:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for mozcrash 02:12:40 INFO - Running setup.py install for mozdebug 02:12:40 INFO - Running setup.py install for mozdevice 02:12:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for mozfile 02:12:40 INFO - Running setup.py install for mozhttpd 02:12:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for mozinfo 02:12:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for mozInstall 02:12:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for mozleak 02:12:40 INFO - Running setup.py install for mozlog 02:12:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:40 INFO - Running setup.py install for moznetwork 02:12:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Running setup.py install for mozprocess 02:12:41 INFO - Running setup.py install for mozprofile 02:12:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Running setup.py install for mozrunner 02:12:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Running setup.py install for mozscreenshot 02:12:41 INFO - Running setup.py install for moztest 02:12:41 INFO - Running setup.py install for mozversion 02:12:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:41 INFO - Cleaning up... 02:12:41 INFO - Return code: 0 02:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:41 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:41 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 02:12:41 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 02:12:41 INFO - Using env: {'DISPLAY': ':0', 02:12:41 INFO - 'HOME': '/home/cltbld', 02:12:41 INFO - 'LANG': 'en_US.UTF-8', 02:12:41 INFO - 'LANGUAGE': 'en_US:en', 02:12:41 INFO - 'LOGNAME': 'cltbld', 02:12:41 INFO - 'MAIL': '/var/mail/cltbld', 02:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:41 INFO - 'MOZ_NO_REMOTE': '1', 02:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:41 INFO - 'NO_EM_RESTART': '1', 02:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:41 INFO - 'PWD': '/builds/slave/test', 02:12:41 INFO - 'SHELL': '/bin/bash', 02:12:41 INFO - 'SHLVL': '1', 02:12:41 INFO - 'TERM': 'linux', 02:12:41 INFO - 'TMOUT': '86400', 02:12:41 INFO - 'USER': 'cltbld', 02:12:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:41 INFO - '_': '/tools/buildbot/bin/python'} 02:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:41 INFO - Running setup.py (path:/tmp/pip-UVPwwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:42 INFO - Running setup.py (path:/tmp/pip-PIjQuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:42 INFO - Running setup.py (path:/tmp/pip-voew5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:42 INFO - Running setup.py (path:/tmp/pip-o9Dx2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:42 INFO - Running setup.py (path:/tmp/pip-kzqj0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:42 INFO - Running setup.py (path:/tmp/pip-LY9NBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:42 INFO - Running setup.py (path:/tmp/pip-0Fmjmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:42 INFO - Running setup.py (path:/tmp/pip-MiAFcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:42 INFO - Running setup.py (path:/tmp/pip-zzMzHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:42 INFO - Running setup.py (path:/tmp/pip-YzmCBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:42 INFO - Running setup.py (path:/tmp/pip-gaGSRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:42 INFO - Running setup.py (path:/tmp/pip-fydOBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:42 INFO - Running setup.py (path:/tmp/pip-787mZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:42 INFO - Running setup.py (path:/tmp/pip-_Ut9Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:42 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)) 02:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:42 INFO - Running setup.py (path:/tmp/pip-0IEamQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:43 INFO - Running setup.py (path:/tmp/pip-MoWgFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:43 INFO - Running setup.py (path:/tmp/pip-7kdTAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:43 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)) 02:12:43 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)) 02:12:43 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)) 02:12:43 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)) 02:12:43 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)) 02:12:43 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)) 02:12:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12:43 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 02:12:43 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 02:12:43 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 02:12:43 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 02:12:43 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 02:12:43 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 02:12:45 INFO - Downloading blessings-1.6.tar.gz 02:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:45 INFO - Installing collected packages: blessings 02:12:45 INFO - Running setup.py install for blessings 02:12:45 INFO - Successfully installed blessings 02:12:45 INFO - Cleaning up... 02:12:45 INFO - Return code: 0 02:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:45 INFO - Reading from file tmpfile_stdout 02:12:45 INFO - Current package versions: 02:12:45 INFO - argparse == 1.2.1 02:12:45 INFO - blessings == 1.6 02:12:45 INFO - blobuploader == 1.2.4 02:12:45 INFO - docopt == 0.6.1 02:12:45 INFO - functools32 == 3.2.3-2 02:12:45 INFO - jsonschema == 2.5.1 02:12:45 INFO - manifestparser == 1.1 02:12:45 INFO - mozInstall == 1.12 02:12:45 INFO - mozcrash == 0.17 02:12:45 INFO - mozdebug == 0.1 02:12:45 INFO - mozdevice == 0.48 02:12:45 INFO - mozfile == 1.2 02:12:45 INFO - mozhttpd == 0.7 02:12:45 INFO - mozinfo == 0.9 02:12:45 INFO - mozleak == 0.1 02:12:45 INFO - mozlog == 3.2 02:12:45 INFO - moznetwork == 0.27 02:12:45 INFO - mozprocess == 0.23 02:12:45 INFO - mozprofile == 0.28 02:12:45 INFO - mozrunner == 6.12 02:12:45 INFO - mozscreenshot == 0.1 02:12:45 INFO - mozsystemmonitor == 0.3 02:12:45 INFO - moztest == 0.7 02:12:45 INFO - mozversion == 1.4 02:12:45 INFO - psutil == 3.1.1 02:12:45 INFO - requests == 1.2.3 02:12:45 INFO - wsgiref == 0.1.2 02:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:45 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')]} 02:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:45 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')]} 02:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:45 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:45 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 02:12:45 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 02:12:45 INFO - Using env: {'DISPLAY': ':0', 02:12:45 INFO - 'HOME': '/home/cltbld', 02:12:45 INFO - 'LANG': 'en_US.UTF-8', 02:12:45 INFO - 'LANGUAGE': 'en_US:en', 02:12:45 INFO - 'LOGNAME': 'cltbld', 02:12:45 INFO - 'MAIL': '/var/mail/cltbld', 02:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:45 INFO - 'MOZ_NO_REMOTE': '1', 02:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:45 INFO - 'NO_EM_RESTART': '1', 02:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:45 INFO - 'PWD': '/builds/slave/test', 02:12:45 INFO - 'SHELL': '/bin/bash', 02:12:45 INFO - 'SHLVL': '1', 02:12:45 INFO - 'TERM': 'linux', 02:12:45 INFO - 'TMOUT': '86400', 02:12:45 INFO - 'USER': 'cltbld', 02:12:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:45 INFO - '_': '/tools/buildbot/bin/python'} 02:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 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)) 02:12:45 INFO - Cleaning up... 02:12:45 INFO - Return code: 0 02:12:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12:45 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')]} 02:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:45 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')]} 02:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:45 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 0xfc3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', '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 02:12:45 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 02:12:45 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 02:12:45 INFO - Using env: {'DISPLAY': ':0', 02:12:45 INFO - 'HOME': '/home/cltbld', 02:12:45 INFO - 'LANG': 'en_US.UTF-8', 02:12:45 INFO - 'LANGUAGE': 'en_US:en', 02:12:45 INFO - 'LOGNAME': 'cltbld', 02:12:45 INFO - 'MAIL': '/var/mail/cltbld', 02:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:45 INFO - 'MOZ_NO_REMOTE': '1', 02:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:45 INFO - 'NO_EM_RESTART': '1', 02:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:45 INFO - 'PWD': '/builds/slave/test', 02:12:45 INFO - 'SHELL': '/bin/bash', 02:12:45 INFO - 'SHLVL': '1', 02:12:45 INFO - 'TERM': 'linux', 02:12:45 INFO - 'TMOUT': '86400', 02:12:45 INFO - 'USER': 'cltbld', 02:12:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:45 INFO - '_': '/tools/buildbot/bin/python'} 02:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:12:45 INFO - Cleaning up... 02:12:45 INFO - Return code: 0 02:12:45 INFO - Running post-action listener: _resource_record_post_action 02:12:45 INFO - Running post-action listener: _start_resource_monitoring 02:12:46 INFO - Starting resource monitoring. 02:12:46 INFO - ##### 02:12:46 INFO - ##### Finished create-virtualenv step (success) 02:12:46 INFO - ##### 02:12:46 INFO - ##### 02:12:46 INFO - ##### Running install step. 02:12:46 INFO - ##### 02:12:46 INFO - Running pre-action listener: _resource_record_pre_action 02:12:46 INFO - Running main action method: install 02:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:46 INFO - Reading from file tmpfile_stdout 02:12:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:46 INFO - Reading from file tmpfile_stdout 02:12:46 INFO - Output received: 02:12:46 INFO - Usage: mozinstall [options] installer 02:12:46 INFO - Options: 02:12:46 INFO - -h, --help show this help message and exit 02:12:46 INFO - -d DEST, --destination=DEST 02:12:46 INFO - Directory to install application into. [default: 02:12:46 INFO - "/builds/slave/test"] 02:12:46 INFO - --app=APP Application being installed. [default: firefox] 02:12:46 INFO - mkdir: /builds/slave/test/build/application 02:12:46 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'] 02:12:46 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 02:13:03 INFO - Reading from file tmpfile_stdout 02:13:03 INFO - Output received: 02:13:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:03 INFO - Running post-action listener: _resource_record_post_action 02:13:03 INFO - ##### 02:13:03 INFO - ##### Finished install step (success) 02:13:03 INFO - ##### 02:13:03 INFO - ##### 02:13:03 INFO - ##### Running run-tests step. 02:13:03 INFO - ##### 02:13:03 INFO - Running pre-action listener: _resource_record_pre_action 02:13:03 INFO - Running main action method: run_tests 02:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:03 INFO - Python 2.7.3 02:13:03 INFO - Return code: 0 02:13:03 INFO - grabbing minidump binary from tooltool 02:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:03 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 0x12823b0>, '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 0x12832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1283740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:03 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 02:13:03 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 02:13:03 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 02:13:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:03 INFO - Return code: 0 02:13:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:13:03 INFO - Using env: {'DISPLAY': ':0', 02:13:03 INFO - 'HOME': '/home/cltbld', 02:13:03 INFO - 'LANG': 'en_US.UTF-8', 02:13:03 INFO - 'LANGUAGE': 'en_US:en', 02:13:03 INFO - 'LOGNAME': 'cltbld', 02:13:03 INFO - 'MAIL': '/var/mail/cltbld', 02:13:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:03 INFO - 'MOZ_NO_REMOTE': '1', 02:13:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:03 INFO - 'NO_EM_RESTART': '1', 02:13:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:03 INFO - 'PWD': '/builds/slave/test', 02:13:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:03 INFO - 'SHELL': '/bin/bash', 02:13:03 INFO - 'SHLVL': '1', 02:13:03 INFO - 'TERM': 'linux', 02:13:03 INFO - 'TMOUT': '86400', 02:13:03 INFO - 'USER': 'cltbld', 02:13:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581', 02:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:03 INFO - '_': '/tools/buildbot/bin/python'} 02:13:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:13:03 INFO - mozversion application_buildid: 20160719013221 02:13:03 INFO - mozversion application_changeset: 65524ee7219ac01b54b89836b67d70ea9d818dbc 02:13:03 INFO - mozversion application_display_name: Nightly 02:13:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:03 INFO - mozversion application_name: Firefox 02:13:03 INFO - mozversion application_remotingname: firefox 02:13:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:13:03 INFO - mozversion application_vendor: Mozilla 02:13:03 INFO - mozversion application_version: 50.0a1 02:13:03 INFO - mozversion platform_buildid: 20160719013221 02:13:03 INFO - mozversion platform_changeset: 65524ee7219ac01b54b89836b67d70ea9d818dbc 02:13:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:13:03 INFO - mozversion platform_version: 50.0a1 02:13:03 INFO - using testdate: 1468919583 02:13:03 INFO - actual date: 1468919583 02:13:03 INFO - starting webserver on 'localhost:43926' 02:13:03 INFO - SUITE-START | Running 2 tests 02:13:03 INFO - TEST-START | dromaeo_css 02:13:03 INFO - operating with platform_type : linux_ 02:13:03 INFO - Initialising browser for dromaeo_css test... 02:13:03 INFO - TEST-INFO | started process 14501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJxyCBQ/profile http://localhost:43926/getInfo.html) 02:13:07 INFO - PROCESS | 14501 | __metrics Screen width/height:1600/1200 02:13:07 INFO - PROCESS | 14501 | colorDepth:24 02:13:07 INFO - PROCESS | 14501 | Browser inner width/height: 1024/697 02:13:07 INFO - PROCESS | 14501 | __metrics 02:13:08 INFO - PROCESS | 14501 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:13:08 INFO - PROCESS | 14501 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:09 INFO - TEST-INFO | 14501: exit 0 02:13:09 INFO - Browser initialized. 02:13:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:09 INFO - TEST-INFO | started process 14582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJxyCBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:21 INFO - PROCESS | 14582 | RSS: Main: 159260672 02:13:21 INFO - PROCESS | 14582 | 02:14:12 INFO - PROCESS | 14582 | 1468919652258 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] 02:16:24 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43926/tests/dromaeo/cssquery-ext.html) 02:16:26 INFO - PROCESS | 14582 | RSS: Main: 272965632 02:16:26 INFO - PROCESS | 14582 | 02:19:28 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-ext.html (next: http://localhost:43926/tests/dromaeo/cssquery-jquery.html) 02:19:29 INFO - PROCESS | 14582 | RSS: Main: 238551040 02:19:29 INFO - PROCESS | 14582 | 02:22:31 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43926/tests/dromaeo/cssquery-mootools.html) 02:22:32 INFO - PROCESS | 14582 | RSS: Main: 244547584 02:22:32 INFO - PROCESS | 14582 | 02:25:34 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43926/tests/dromaeo/cssquery-prototype.html) 02:25:35 INFO - PROCESS | 14582 | RSS: Main: 243929088 02:25:35 INFO - PROCESS | 14582 | 02:28:38 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43926/tests/dromaeo/cssquery-yui.html) 02:28:38 INFO - PROCESS | 14582 | RSS: Main: 211243008 02:28:38 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-yui.html (next: http://localhost:43926/tests/dromaeo/cssquery-dojo.html) 02:31:41 INFO - PROCESS | 14582 | RSS: Main: 297807872 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | __start_tp_report 02:31:41 INFO - PROCESS | 14582 | _x_x_mozilla_page_load 02:31:41 INFO - PROCESS | 14582 | _x_x_mozilla_page_load_details 02:31:41 INFO - PROCESS | 14582 | |i|pagename|runs| 02:31:41 INFO - PROCESS | 14582 | |0;dojo.html;2621.9606705899405;2627.3956989892326;2669.7196794336583;2678.142994241842;2678.142994241842;4591.24244499658;4640.118377508271;4716.589988360881;4783.832565860192;4827.227643577024;4678.929816052753;4721.480637129922;4732.455767586728;4734.337192793012;4738.076075165344;4121.670266378683;4299.699021068519;4389.078293558357;4419.116176764644;4457.286834106543;4357.41174941382;4401.3397990301555;4413.139437809628;4425.31407631816;4454.443194600675;4268.231718290706;4323.113761678848;4338.479382474124;4356.194104090753;4391.341298805205;4291.914161716748;4296.957030429687;4298.118885628439;4355.934660980088;4374.103308821684;4323.200207961506;4340.913181736348;4357.324614684697;4381.298992161271;4402.8679139625865;4577.359169716243;4629.143608432417;4678.625709943196;4695.084458530588;4699.060187962421;5074.31496747938;5098.719570423626;5133.820316288912;5146.279520867044;5148.716820574867;5144.305518754958;5158;5173.637845350827;5182.041322355376;5183.170692689152;4583.587477127075;4664.300354946785;4782.067496838084;4791.113643975876;4862.3922009748785;5285.524302812765;5295.629305948623;5319.882824606799;5321.5476684482255;5324.387695414999;4840;5087.669301495391;5095.210242412432;5095.363079615048;5097.057044446789;5057.266696329012;5097.1844504879045;5112.71880046601;5116.079105760924;5137.101007323703;5086.415062267813;5093.871202528485;5094.083065048253;5106.234064890222;5147.253648220987;4857.319975203474;4896.363472748591;5070.442251352349;5075.746212689351;5086.440491545927;4325.7188282762145;4371.169477799208;4373.715708478939;4385.473743150842;4398.8020539075815;3786.2238241160494;3799.3920972644796;3811.5045044144085;3840.577536470986;3841.519810023747;4290.742555446621;4386.517483076859;4397.73613583186;4444.533324000933;4446.3108218226225;5061.620378471629;5112.207607820794;5125.15434953236;5177.508136727005;5197.688138711689;4412.492563355255;4419.9779001105435;4423.270160423494;4423.756693381895;4463.464384273908;4646.233371493666;4655.255159174516;4660.067986402733;4661.091087238024;4701.576858082721;4636.744979026186;4786.329913812138;4830;4836.903261934812;4847.951520484891;5150.742462876916;5159.793608255778;5159.974200128975;5160;5209.322788037531;4680.976595117003;4806;4839.249916262844;4854.05345957549;4899.902001960012;5011.473795251446;5063.924041139312;5066.265391518135;5072.416672082758;5086.364204474441;5147.819826306061;5166.4058633257655;5167.062715148937;5168.689878607295;5219.556337711337;4811;4969.403671559291;5007.123753343223;5018.021485810232;5018.071656743514;5004.174311238605;5035.697858128524;5055.292259083805;5059.544640982329;5101.489851015017;4961.181405068123;4969.801207951641;5018.4730603286125;5020.297158397754;5028.59771218309;4834.3231947528075;4942.986687729079;5005.074061298671;5060.620453466078;5070.062038522885;4896.143174944299;4910.803567857246;4916.06594746997;4916.188828843201;4949.777260023236 02:31:41 INFO - PROCESS | 14582 | |1;ext.html;538.8709370842046;583.4602992232184;596.3738075021228;599.6402158704775;603.2429301226958;26084;38176.236475270474;39229;39300;39353.21293574131;39378.606213937856;39684.80157599208;39777.20445591086;39787;39801.40297895534;7841.607919604011;7850.528968261894;7940.444168908179;7959.840803183933;7971.840563188733;7803.960980195091;7863.803404914895;7869.645865936047;9978.90021099787;10254.384736915772;10359.482025898713;10422.114120299746;10424.166066714644;10425.79148417035;10428;10079.596816127383;10133;10180.949095254551;10187.79624407515;10216.540255688511;7631.961840190819;9820.508974551316;10228.948855255676;10231.795364092677;10610.522526486327;38692.22615547673;38859.8057009716;38983.8050809747;39026.41460378097;39031.024224394336;3120.625524936999;3164.2247649326064;3193.379651812803;3219.5331676906953;3734.9626503734885;28656.283592910346;29047.12858614245;29150.27124321888;29220.415591688048;30007.849960750274;3251.707346338841;3364.4280472319765;3391.084407210064;3422.7946323220685;3552.2540266544056;157839;159153.99999999884;160068;161407;161669;53120.734396327774;53681;53761.731191343795;53810.461895381326;53993.46006539963;32856.178595534824;33673.83163084218;33675.32649346999;35291.117722057155;56805.431945680844;15239.695206096038;15372.308246128727;15406.22968851553;15410.845891541165;15438;10615.946920265504;10939.617113400993;10968.451577421256;11006.449677516091;11013.83479247812;17615.735763963552;18051.187696553687;18378;18921.81078189228;19029.61940761177;6576.375244351779;6784.660766961632;6915.619640919797;7035.7185712571945;7055.753048643272;742.8514297140485;785.3246208260891;892.4912799704236;902.3638334973828;983.9029482127377;27441.86279068632;27524.862375687993;27750.3062423437;27806.165815025583;27886.581701274496;934.0146145816093;937.2174234514257;993.215359865698;1020.336781092296;1078.5793540519203;14312;14726.337314820645;14849.406023759144;14912.84763997586;14981.176035317943;125516.37241813733;125718;125929.37035314948;126027;127376.36311818568;48276.5172348279;48673.26990095151;48685;48704.51295487;48789.5121048785;1085.4898197846999;1168.7720894425506;1172.7302720374532;1181.8109102543551;1190.1490434339316;27211.319717007234;28510.019343906602;28527;28783.5682464759;28888.566671500364;40665;40897.38653920253;41161;41165;41297.587024130575;290751;292010;292406;292434;292966;22074.558508830054;24292.392690182885;24897.377565561004;25077.122300719388;26194.73805261923;40146.39780403238;40746.38880416737;40801;41614.791926041384;42045.57954420416;34593.30813383769;34874.65125348714;34928.65071349254;35833.82083089568;35866.82066589755;34864;35401.46897796483;35792.64207357893;35808.28383432265;36204.09489762777;31271.374572508877;31911.6808831918;32116.19709507281;32185.839070804497;34914;30026;32053.839730801195;32594.51108233426;32775.34449310953;32818;24446.511069778862;24826;24922.87538562368;25202;25246 02:31:41 INFO - PROCESS | 14582 | |2;jquery.html;341.2100986216909;365.85731564689775;369.1251733391862;374.74891822478946;384.45215567815853;13117;16316.184190790458;16736.748948765777;17898.463046108605;17911.462656120304;15921;15968.520944371687;16452.83547164528;17262.136893155355;17589.296428142858;4448.243798554237;5216.3218781558435;5324.600654950875;5325.547328477084;5333.546648534879;3777.0934975605796;3992.500937382827;5970.641761494303;6261.279952805417;6277.748890044393;5160.612954028444;6282.905756413657;6311.968440157816;6322.336154703758;6331.77838775643;5432.837014889559;5446.373667028263;5454.7272636368225;5475.890482190334;5476.151196564539;4713.882152946169;4994.051130285234;5276.841694749163;5290.523852853224;5293.23248129023;12356.25862448247;12489.50041998328;12627.305498197595;12720.809187862189;12734.554290599877;1815.5370380553006;1821.717633766755;1835.7613510243716;1839.9264029438807;1861.6183682345086;8963.14850089247;10407.68776936693;12771.425285862066;13349.799753003712;13589.932050339783;1682.0412364951983;1691.534827922319;1707.795064592257;1714.3913910561696;1769.6106856491551;62357.68821155865;68020.6598967002;68852.3114768851;69256;70524.6473767633;9415.199708024895;9604.471754053595;9829.606815727433;10026.548805303779;10137.645182418728;13747;13841.100328478617;13849.238291894042;13852.09961352529;13857.307134643228;6864.347886950732;6894.482913781487;6928.584284942919;7027.5080744348425;7041.753538626123;6523.836904077341;6542.967285163639;6626.304238054935;6645.867082658319;6666.033425153326;4280.636145927631;4300.419443375167;4358.5205627380965;4374.715643483163;4460.977695111504;1678.5971366871863;1720.1227374039079;1825.2425243524053;1839.4297767691792;1887.6319117771902;831.6881169561415;841.3227351981714;882.5454890731279;947.4836214263244;971.820213260549;16615.41846035383;16748.497545073424;17028.829711702972;17349.653006940043;17511.73732394015;823.1398188892622;828.2504333578122;851.9233269005696;891.460666296894;909.3225546967551;9254.259659227246;9677.129058384779;9744.610215591298;9752.463614501128;9900.108990190918;368128;371341;373176;373663;379180;57910.7104464475;74305;74321.25678743252;74903.25096749072;76562.61718691482;840.9404150770074;853.5732133933034;858.2275951643446;880.3793325705362;887.6094518411878;14088.577342679737;15038.774418383951;15456.459023934109;15468.14925179081;15469.5359139226;35699.64300356963;36779.26441471209;36893;36938.81530592437;37086.44370334501;46754;47936.56190314296;48336.98675281741;49286.26070609016;55770.72114639401;7590.734324298623;7686.730964416219;7781.844363112819;7890.723824666109;7984.600769961363;10424.68725938223;12044.518219271482;12105;12131.514739410324;12165.69585760363;10397.11624511925;10545.894541054491;10553.153198190439;10769.192310576582;10826.512806923865;10156.289059765746;10659.626913058317;10726.141908647445;10979.945100274766;11114;10433.634822781167;10461.163106951577;10463.68608941733;10467.057964783206;10528.94735526348;7569.735059272899;7728.188540203422;7776.7278145264645;7780.183080776664;8035.477693949874;10101.898981010096;10227.7443063924;10272.435016074187;10279.794404111726;10474 02:31:41 INFO - PROCESS | 14582 | |3;mootools.html;1373.9862601373986;1407.1135184833554;1495.192595998161;1676.0530300380276;1712.4605749189013;7397.2602739726;7872.0947091084545;7925.524468531892;7951.562664053475;7953.681852725891;6629.3370662933685;6844.349786770262;7438.4793064485375;7677.808054798619;7686.807829804244;2183.6178668732946;2207.602631526325;2210.35899589119;2211.4360837986374;2214.30249471416;1841.116264193188;2174;2187.55155193185;2193.166596693254;2204.041242059709;2103.957920841582;2161.3083813179787;2170.468235282358;2188.391532223814;2195.264586363562;2185.7049298344677;2198.6482162853868;2207.558488302346;2220.3449982255274;2233.129079658934;2193.638049721794;2194.5501172259646;2201.5266717655622;2201.5486825200796;2202.559488102386;7951.761447156595;7996.680132794681;7997.080335761346;8002.759917202493;8010.639521221559;4642.582167604932;4741.691790033637;4800.135975524404;4804.303376010494;4812.085703716318;2814.2925719938103;2902.680705122435;2939.456200602874;2941.5734718465915;2970.6880777518268;896.2247655777705;907.2968449451662;912.6668765900465;917.9495127767971;921.9078092190795;10603.469826508644;10621.787564248749;10624.309419887682;10649.148068154607;10669.199810014203;4114.6091121343425;4255.787210639455;4357.847475338412;4370.8907277317685;4392.604665580113;9118.088191180961;9179.908200918038;9179.954100229455;9185.081491850895;9190.724278271662;4810.11012962603;4811.182099043171;4811.230203167476;4812.085703716282;4816.54242846929;4288.699791014599;4337.219300525936;4377.518472967971;4388.363687265392;4395.7362558246605;3668.669819716185;3711.4432835074954;3750.5499340079364;3763.473113764075;3806.0865392305645;1103.1064837481665;1195.49789088583;1208.4380762945273;1212.630147804928;1233.802591585342;862.7886167888907;867.2974890338845;877.863931090682;886.6483801616106;905.8505346617734;5353.250544923714;5395.946040539623;5568.387477377485;5610.242617246701;5660.320761508563;905.5879574793453;907.1155623267261;921.2906062331967;938.3572253006575;969.520087556664;3419.350323438539;3596.1369271374683;3681.079730067483;3684.09739613791;3687.465317528943;9488.240940724725;9623.759406014906;9629.951850240705;9699.612015519442;9793.412395256308;9479;9739.513024348755;9755.317127801127;9761.463119528495;9765.755856103655;7004.684789184397;7218.927810721931;7346.11846578414;7353.77938661841;7362.226966168582;5412.161115027177;5422.457754224703;5506.394296627288;5523.895220955745;5614;8990.056044115274;9133.40632858862;9188.540572971191;9192.35653504275;9223.216026637543;8716.912830871865;8978.640854365753;8986.82026359456;9019.639214431349;9232.907670923205;7193.928060719326;7284.890726639211;7298.051253337032;7421.2949769771785;7479.775606731807;7452.515586486861;7525.736599219001;7526.209747976383;7528.548287102572;7543.434242431949;6731.730730770714;6748.460123190232;6843.315668433117;6890.586564806128;6918.0314755935215;6614.074029635759;6618.470522358296;6673.566218195801;6796.66016699173;6801.353871382211;6537.444317232898;6585.901211481927;6595.472362210916;6604.735810567716;6634.303398143125;4660.650451216105;4677.368555244999;4719.457262414866;4732.834350797705;4779.617630589614;4719.05618876233;4791.664583479263;4819.903601928012;4840.2255639097575;4841.927371089507 02:31:41 INFO - PROCESS | 14582 | |4;prototype.html;294.0516833212888;295.11171374163763;301.9048999565137;304.6100990731864;304.6800859097947;4799.5680388765;4813.181759100952;4835.419749630045;4846.764075160833;4856.660033797635;4769.809207631691;4770.5670108244785;4770.950390914002;4772.635292119056;4799.496052914446;3600.3519366514083;3726.6273372662786;3731.7014638828828;3779;3797.126660868002;3768.321702093622;3797.411401232813;3808.5239345081864;3809.314323421797;3810.247286248329;3777.452269420932;3780.017195529155;3787.110029143149;3798.1454172811173;3799.4300854871854;3590.4434812604086;3665.395209790368;3740.1673180141806;3779.1496913194587;3784.2053168834577;3335.366280406715;3336.182635254354;3344.2976974835315;3354.228527438678;3356.2280675444786;4650.18621741194;4651.3023046543285;4666.789994450224;4682.6253899687945;4692.694974826625;4172.3532852407925;4321.416608757809;4335.436393268855;4349.195398851222;4355.782210889474;5004.399472063339;5014.749262536895;5022.869854282793;5030.647854650176;5030.84907452777;3673.1716578234877;3680.1535646801385;3687.8340474678703;3689.8524059037604;3703.3148867459604;5103.923441148386;5230.861483110103;5258.6318957672975;5296.602754793367;5303.064381500763;3774.7735135891935;3781.773093614392;3784.299904517673;3786.2995345861104;3790.1851102012647;3824.623135671156;3826;3833.9424908626393;3844.1735026969336;3851.691864650821;4305.677074219383;4307;4312.072904325585;4323.524412314643;4326.610605045561;4872.123017856749;5032.572231360376;5040.596752259884;5056.595472362203;5076.36545431821;1321.6167311479562;1333.639917222364;1335.1988806715892;1340.8189894364332;1344.764666183414;843.355456859115;861.4443683823898;870.2950610005915;876.912308769118;885.2121611765534;4378.408914796525;4453.51011388747;4479.238529450001;4505.707129036602;4512.503624601291;5207.895842083213;5212.087884620252;5213.947860521422;5228.529432351031;5231.921521177185;4485.730856148642;4494.438195225597;4501.347304640874;4501.392312037833;4506.211413002711;2608.2957601447883;2793.9022134225206;2798.958015629767;2799.174243598143;2807.764583583217;4959.008198360342;4963.677360971526;4972.378452693413;4979.626528010342;4979.825706100269;5236.554892834076;5339.46605339463;5397.055515284809;5398.109311963561;5404.54061404785;4950.752462376939;4971.304017437562;4971.925421118686;4974.676646017997;4985.401751789808;5237.590708274084;5264.78940842362;5266.55234305073;5275.314209152785;5283.735813209248;5007.974960125176;5110.642255042111;5164.664296820694;5180.585553155664;5184.174624829552;4907.263910413467;4939.53074457926;4965.18074517715;4972.3535940328975;4980.850574482772;3406.7444941628983;3407;3413.5050417689795;3419.26485805553;3425.6574342565546;4636.235021221595;4640.978984623377;4654.581087702123;4665.4634717007975;4893.853184404474;5050.823221187241;5063.721495317645;5106.846794596168;5111.79552817898;5115.411727651219;5031.547160755403;5038.697678139177;5054.974725126351;5078.542931136068;5092.701361152882;4826.348442960156;5018.372703412074;5019.472955339636;5020.121478741133;5045.217991211368;4843.612510999182;4975;5097.8725531862;5099.628672667228;5111.718855462986;4955.72743499111;4993;4995.300657907968;5019.322391477104;5025.271335656236 02:31:41 INFO - PROCESS | 14582 | |5;yui.html;595.9195508606339;663.9601623902569;689.1076056506823;701.2251462134342;727.6652739739719;12083.395830208487;12757.107002509829;12758.234505929651;12824.294663793487;12849.164804287726;11723.648290551277;11729.178957472981;11735.29588224705;11746.823797643043;11899.286042837435;619.3929948650325;753.5892938348586;765.4832987733286;776.1268572855538;778.8636988527013;772.4052479590712;775.0196002057402;775.9340456061213;776.6272189349088;779.2246714519061;816.9264766171043;818.5620692929284;818.6684392820918;818.7175424478545;819.4141189049828;644.2784081828336;658.713459645056;661.5137873662854;664.6344510519243;810.8297257575887;577.2582231832075;591.6804925340311;595.4730063893486;596.1534620838377;597.1818608506375;12999.960003199722;13006.479740810357;13021.479140834355;13026.218426894417;13060;11912.642620721392;12188.573399931049;12279.91241488949;12293.385330733518;12599.93700031503;11104.888951110546;11242.213045086848;11257.71855703614;11427.48576314068;11626.651200463999;4128.071183983609;4182.414461975326;4193.97903010483;4243.766592837393;4322.243607368698;57830;57924;59201.7039914802;59986.40013599852;60088.399116009154;9717.902820971842;9797.951010244904;9824.263180261509;9918.30571859963;9949.502524873873;17924.103794810206;17971.550711232063;18007.369742058963;18069.7289540657;18088.00515971634;6918.481113916477;6965.686544105527;7007.229204787469;7070.858582828315;7250.16623088341;3488.0582242794812;3547.822608869546;3579.4093974493917;3586.1572530455323;3595.7662751921566;2777.291790593386;2852.8430936298287;2879.424115176973;2880.2943278896387;2880.5967164596973;507.2214151277771;507.33032397235297;516.032439176544;528.6246764797037;530.6815910453774;430.6877513802531;466.89494863655403;520.0950346397242;529.8569386265686;564.4496615799562;7509.887351689729;7623.504472209289;7666.198851364143;7751;7798.181190974866;524.5698527207729;541.775163307231;545.476342710994;559.6683446846281;579.4090028171325;3717.8698745544316;3722.7952462614276;3735.701143908481;3758.3047136279874;3832.865849695247;91280.54359728159;91721;95140.52429737807;95163;95420;46942.76528617335;64836;74461;77765.83351249735;81191.5940420294;45273.547264527595;71842.64078679678;73646.26353736501;73728;75173;8596.828063438572;9109.817803644022;9208.723738287863;9217.354785164975;9385.624575017197;42365.78817105895;43979.560204398826;44345.77827110844;45525.54474455213;45632.31551526664;62360.68819655872;63461;63565.6821715907;63631.68184159049;63817;10608.575656973635;11368.715782105513;11474.368909709712;11589.420528973349;12033.63899083029;11227.326360418401;11410.201285910238;11735;11762.411879406167;11794.823077654013;10790.244682872124;10892.40091794959;11155.27490713101;11198.664040078811;11454;10179.898201018192;10364.170866330825;10501.422421766876;10591.89408105909;10747.677569672922;12127.151099422956;12180.634580962585;12367.134300598871;12432.378381081091;12809.654986226686;9518.571664274985;9557.187639050759;9560.904390956;9880.061394167542;9911;8949.194572488508;9618.759531011781;9730;9898.257630677585;10024.799504010025 02:31:41 INFO - PROCESS | 14582 | __end_tp_report 02:31:41 INFO - PROCESS | 14582 | __start_cc_report 02:31:41 INFO - PROCESS | 14582 | _x_x_mozilla_cycle_collect,1151 02:31:41 INFO - PROCESS | 14582 | __end_cc_report 02:31:41 INFO - PROCESS | 14582 | __startTimestamp1468920701943__endTimestamp 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | ------- Summary: start ------- 02:31:41 INFO - PROCESS | 14582 | Number of tests: 6 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#0] dojo.html Cycles:165 Average:4722.00 Median:4839.25 stddev:506.90 (10.5%) stddev-sans-first:480.93 02:31:41 INFO - PROCESS | 14582 | Values: 2622.0 2627.4 2669.7 2678.1 2678.1 4591.2 4640.1 4716.6 4783.8 4827.2 4678.9 4721.5 4732.5 4734.3 4738.1 4121.7 4299.7 4389.1 4419.1 4457.3 4357.4 4401.3 4413.1 4425.3 4454.4 4268.2 4323.1 4338.5 4356.2 4391.3 4291.9 4297.0 4298.1 4355.9 4374.1 4323.2 4340.9 4357.3 4381.3 4402.9 4577.4 4629.1 4678.6 4695.1 4699.1 5074.3 5098.7 5133.8 5146.3 5148.7 5144.3 5158.0 5173.6 5182.0 5183.2 4583.6 4664.3 4782.1 4791.1 4862.4 5285.5 5295.6 5319.9 5321.5 5324.4 4840.0 5087.7 5095.2 5095.4 5097.1 5057.3 5097.2 5112.7 5116.1 5137.1 5086.4 5093.9 5094.1 5106.2 5147.3 4857.3 4896.4 5070.4 5075.7 5086.4 4325.7 4371.2 4373.7 4385.5 4398.8 3786.2 3799.4 3811.5 3840.6 3841.5 4290.7 4386.5 4397.7 4444.5 4446.3 5061.6 5112.2 5125.2 5177.5 5197.7 4412.5 4420.0 4423.3 4423.8 4463.5 4646.2 4655.3 4660.1 4661.1 4701.6 4636.7 4786.3 4830.0 4836.9 4848.0 5150.7 5159.8 5160.0 5160.0 5209.3 4681.0 4806.0 4839.2 4854.1 4899.9 5011.5 5063.9 5066.3 5072.4 5086.4 5147.8 5166.4 5167.1 5168.7 5219.6 4811.0 4969.4 5007.1 5018.0 5018.1 5004.2 5035.7 5055.3 5059.5 5101.5 4961.2 4969.8 5018.5 5020.3 5028.6 4834.3 4943.0 5005.1 5060.6 5070.1 4896.1 4910.8 4916.1 4916.2 4949.8 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#1] ext.html Cycles:180 Average:36382.67 Median:17702.69 stddev:53767.25 (303.7%) stddev-sans-first:53850.72 02:31:41 INFO - PROCESS | 14582 | Values: 538.9 583.5 596.4 599.6 603.2 26084.0 38176.2 39229.0 39300.0 39353.2 39378.6 39684.8 39777.2 39787.0 39801.4 7841.6 7850.5 7940.4 7959.8 7971.8 7804.0 7863.8 7869.6 9978.9 10254.4 10359.5 10422.1 10424.2 10425.8 10428.0 10079.6 10133.0 10180.9 10187.8 10216.5 7632.0 9820.5 10228.9 10231.8 10610.5 38692.2 38859.8 38983.8 39026.4 39031.0 3120.6 3164.2 3193.4 3219.5 3735.0 28656.3 29047.1 29150.3 29220.4 30007.8 3251.7 3364.4 3391.1 3422.8 3552.3 157839.0 159154.0 160068.0 161407.0 161669.0 53120.7 53681.0 53761.7 53810.5 53993.5 32856.2 33673.8 33675.3 35291.1 56805.4 15239.7 15372.3 15406.2 15410.8 15438.0 10615.9 10939.6 10968.5 11006.4 11013.8 17615.7 18051.2 18378.0 18921.8 19029.6 6576.4 6784.7 6915.6 7035.7 7055.8 742.9 785.3 892.5 902.4 983.9 27441.9 27524.9 27750.3 27806.2 27886.6 934.0 937.2 993.2 1020.3 1078.6 14312.0 14726.3 14849.4 14912.8 14981.2 125516.4 125718.0 125929.4 126027.0 127376.4 48276.5 48673.3 48685.0 48704.5 48789.5 1085.5 1168.8 1172.7 1181.8 1190.1 27211.3 28510.0 28527.0 28783.6 28888.6 40665.0 40897.4 41161.0 41165.0 41297.6 290751.0 292010.0 292406.0 292434.0 292966.0 22074.6 24292.4 24897.4 25077.1 26194.7 40146.4 40746.4 40801.0 41614.8 42045.6 34593.3 34874.7 34928.7 35833.8 35866.8 34864.0 35401.5 35792.6 35808.3 36204.1 31271.4 31911.7 32116.2 32185.8 34914.0 30026.0 32053.8 32594.5 32775.3 32818.0 24446.5 24826.0 24922.9 25202.0 25246.0 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#2] jquery.html Cycles:180 Average:23455.12 Median:189782.23 stddev:61574.35 (32.4%) stddev-sans-first:61722.62 02:31:41 INFO - PROCESS | 14582 | Values: 341.2 365.9 369.1 374.7 384.5 13117.0 16316.2 16736.7 17898.5 17911.5 15921.0 15968.5 16452.8 17262.1 17589.3 4448.2 5216.3 5324.6 5325.5 5333.5 3777.1 3992.5 5970.6 6261.3 6277.7 5160.6 6282.9 6312.0 6322.3 6331.8 5432.8 5446.4 5454.7 5475.9 5476.2 4713.9 4994.1 5276.8 5290.5 5293.2 12356.3 12489.5 12627.3 12720.8 12734.6 1815.5 1821.7 1835.8 1839.9 1861.6 8963.1 10407.7 12771.4 13349.8 13589.9 1682.0 1691.5 1707.8 1714.4 1769.6 62357.7 68020.7 68852.3 69256.0 70524.6 9415.2 9604.5 9829.6 10026.5 10137.6 13747.0 13841.1 13849.2 13852.1 13857.3 6864.3 6894.5 6928.6 7027.5 7041.8 6523.8 6543.0 6626.3 6645.9 6666.0 4280.6 4300.4 4358.5 4374.7 4461.0 1678.6 1720.1 1825.2 1839.4 1887.6 831.7 841.3 882.5 947.5 971.8 16615.4 16748.5 17028.8 17349.7 17511.7 823.1 828.3 851.9 891.5 909.3 9254.3 9677.1 9744.6 9752.5 9900.1 368128.0 371341.0 373176.0 373663.0 379180.0 57910.7 74305.0 74321.3 74903.3 76562.6 840.9 853.6 858.2 880.4 887.6 14088.6 15038.8 15456.5 15468.1 15469.5 35699.6 36779.3 36893.0 36938.8 37086.4 46754.0 47936.6 48337.0 49286.3 55770.7 7590.7 7686.7 7781.8 7890.7 7984.6 10424.7 12044.5 12105.0 12131.5 12165.7 10397.1 10545.9 10553.2 10769.2 10826.5 10156.3 10659.6 10726.1 10979.9 11114.0 10433.6 10461.2 10463.7 10467.1 10528.9 7569.7 7728.2 7776.7 7780.2 8035.5 10101.9 10227.7 10272.4 10279.8 10474.0 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#3] mootools.html Cycles:180 Average:5220.67 Median:5546.14 stddev:2886.55 (52.0%) stddev-sans-first:2880.17 02:31:41 INFO - PROCESS | 14582 | Values: 1374.0 1407.1 1495.2 1676.1 1712.5 7397.3 7872.1 7925.5 7951.6 7953.7 6629.3 6844.3 7438.5 7677.8 7686.8 2183.6 2207.6 2210.4 2211.4 2214.3 1841.1 2174.0 2187.6 2193.2 2204.0 2104.0 2161.3 2170.5 2188.4 2195.3 2185.7 2198.6 2207.6 2220.3 2233.1 2193.6 2194.6 2201.5 2201.5 2202.6 7951.8 7996.7 7997.1 8002.8 8010.6 4642.6 4741.7 4800.1 4804.3 4812.1 2814.3 2902.7 2939.5 2941.6 2970.7 896.2 907.3 912.7 917.9 921.9 10603.5 10621.8 10624.3 10649.1 10669.2 4114.6 4255.8 4357.8 4370.9 4392.6 9118.1 9179.9 9180.0 9185.1 9190.7 4810.1 4811.2 4811.2 4812.1 4816.5 4288.7 4337.2 4377.5 4388.4 4395.7 3668.7 3711.4 3750.5 3763.5 3806.1 1103.1 1195.5 1208.4 1212.6 1233.8 862.8 867.3 877.9 886.6 905.9 5353.3 5395.9 5568.4 5610.2 5660.3 905.6 907.1 921.3 938.4 969.5 3419.4 3596.1 3681.1 3684.1 3687.5 9488.2 9623.8 9630.0 9699.6 9793.4 9479.0 9739.5 9755.3 9761.5 9765.8 7004.7 7218.9 7346.1 7353.8 7362.2 5412.2 5422.5 5506.4 5523.9 5614.0 8990.1 9133.4 9188.5 9192.4 9223.2 8716.9 8978.6 8986.8 9019.6 9232.9 7193.9 7284.9 7298.1 7421.3 7479.8 7452.5 7525.7 7526.2 7528.5 7543.4 6731.7 6748.5 6843.3 6890.6 6918.0 6614.1 6618.5 6673.6 6796.7 6801.4 6537.4 6585.9 6595.5 6604.7 6634.3 4660.7 4677.4 4719.5 4732.8 4779.6 4719.1 4791.7 4819.9 4840.2 4841.9 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#4] prototype.html Cycles:180 Average:4200.36 Median:4770.76 stddev:1214.07 (25.4%) stddev-sans-first:1181.54 02:31:41 INFO - PROCESS | 14582 | Values: 294.1 295.1 301.9 304.6 304.7 4799.6 4813.2 4835.4 4846.8 4856.7 4769.8 4770.6 4771.0 4772.6 4799.5 3600.4 3726.6 3731.7 3779.0 3797.1 3768.3 3797.4 3808.5 3809.3 3810.2 3777.5 3780.0 3787.1 3798.1 3799.4 3590.4 3665.4 3740.2 3779.1 3784.2 3335.4 3336.2 3344.3 3354.2 3356.2 4650.2 4651.3 4666.8 4682.6 4692.7 4172.4 4321.4 4335.4 4349.2 4355.8 5004.4 5014.7 5022.9 5030.6 5030.8 3673.2 3680.2 3687.8 3689.9 3703.3 5103.9 5230.9 5258.6 5296.6 5303.1 3774.8 3781.8 3784.3 3786.3 3790.2 3824.6 3826.0 3833.9 3844.2 3851.7 4305.7 4307.0 4312.1 4323.5 4326.6 4872.1 5032.6 5040.6 5056.6 5076.4 1321.6 1333.6 1335.2 1340.8 1344.8 843.4 861.4 870.3 876.9 885.2 4378.4 4453.5 4479.2 4505.7 4512.5 5207.9 5212.1 5213.9 5228.5 5231.9 4485.7 4494.4 4501.3 4501.4 4506.2 2608.3 2793.9 2799.0 2799.2 2807.8 4959.0 4963.7 4972.4 4979.6 4979.8 5236.6 5339.5 5397.1 5398.1 5404.5 4950.8 4971.3 4971.9 4974.7 4985.4 5237.6 5264.8 5266.6 5275.3 5283.7 5008.0 5110.6 5164.7 5180.6 5184.2 4907.3 4939.5 4965.2 4972.4 4980.9 3406.7 3407.0 3413.5 3419.3 3425.7 4636.2 4641.0 4654.6 4665.5 4893.9 5050.8 5063.7 5106.8 5111.8 5115.4 5031.5 5038.7 5055.0 5078.5 5092.7 4826.3 5018.4 5019.5 5020.1 5045.2 4843.6 4975.0 5097.9 5099.6 5111.7 4955.7 4993.0 4995.3 5019.3 5025.3 02:31:41 INFO - PROCESS | 14582 | 02:31:41 INFO - PROCESS | 14582 | [#5] yui.html Cycles:180 Average:16852.49 Median:529.24 stddev:23608.06 (4460.7%) stddev-sans-first:23642.73 02:31:41 INFO - PROCESS | 14582 | Values: 595.9 664.0 689.1 701.2 727.7 12083.4 12757.1 12758.2 12824.3 12849.2 11723.6 11729.2 11735.3 11746.8 11899.3 619.4 753.6 765.5 776.1 778.9 772.4 775.0 775.9 776.6 779.2 816.9 818.6 818.7 818.7 819.4 644.3 658.7 661.5 664.6 810.8 577.3 591.7 595.5 596.2 597.2 13000.0 13006.5 13021.5 13026.2 13060.0 11912.6 12188.6 12279.9 12293.4 12599.9 11104.9 11242.2 11257.7 11427.5 11626.7 4128.1 4182.4 4194.0 4243.8 4322.2 57830.0 57924.0 59201.7 59986.4 60088.4 9717.9 9798.0 9824.3 9918.3 9949.5 17924.1 17971.6 18007.4 18069.7 18088.0 6918.5 6965.7 7007.2 7070.9 7250.2 3488.1 3547.8 3579.4 3586.2 3595.8 2777.3 2852.8 2879.4 2880.3 2880.6 507.2 507.3 516.0 528.6 530.7 430.7 466.9 520.1 529.9 564.4 7509.9 7623.5 7666.2 7751.0 7798.2 524.6 541.8 545.5 559.7 579.4 3717.9 3722.8 3735.7 3758.3 3832.9 91280.5 91721.0 95140.5 95163.0 95420.0 46942.8 64836.0 74461.0 77765.8 81191.6 45273.5 71842.6 73646.3 73728.0 75173.0 8596.8 9109.8 9208.7 9217.4 9385.6 42365.8 43979.6 44345.8 45525.5 45632.3 62360.7 63461.0 63565.7 63631.7 63817.0 10608.6 11368.7 11474.4 11589.4 12033.6 11227.3 11410.2 11735.0 11762.4 11794.8 10790.2 10892.4 11155.3 11198.7 11454.0 10179.9 10364.2 10501.4 10591.9 10747.7 12127.2 12180.6 12367.1 12432.4 12809.7 9518.6 9557.2 9560.9 9880.1 9911.0 8949.2 9618.8 9730.0 9898.3 10024.8 02:31:41 INFO - PROCESS | 14582 | -------- Summary: end -------- 02:31:41 INFO - PROCESS | 14582 | 02:31:42 INFO - TEST-INFO | 14582: exit 0 02:31:42 INFO - TEST-OK | dromaeo_css | took 1119142ms 02:31:42 INFO - TEST-START | kraken 02:31:42 INFO - operating with platform_type : linux_ 02:31:42 INFO - Initialising browser for kraken test... 02:31:42 INFO - TEST-INFO | started process 14776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZd7lCX/profile http://localhost:43926/getInfo.html) 02:31:46 INFO - PROCESS | 14776 | __metrics Screen width/height:1600/1200 02:31:46 INFO - PROCESS | 14776 | colorDepth:24 02:31:46 INFO - PROCESS | 14776 | Browser inner width/height: 1024/697 02:31:46 INFO - PROCESS | 14776 | __metrics 02:31:47 INFO - PROCESS | 14776 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:31:47 INFO - PROCESS | 14776 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:48 INFO - TEST-INFO | 14776: exit 0 02:31:48 INFO - Browser initialized. 02:31:48 INFO - Running cycle 1/1 for kraken test... 02:31:48 INFO - TEST-INFO | started process 14856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZd7lCX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:00 INFO - PROCESS | 14856 | RSS: Main: 159141888 02:32:00 INFO - PROCESS | 14856 | 02:32:02 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:03 INFO - PROCESS | 14856 | RSS: Main: 218566656 02:32:03 INFO - PROCESS | 14856 | 02:32:06 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-dft) 02:32:07 INFO - PROCESS | 14856 | RSS: Main: 207093760 02:32:07 INFO - PROCESS | 14856 | 02:32:10 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-fft) 02:32:11 INFO - PROCESS | 14856 | RSS: Main: 273489920 02:32:11 INFO - PROCESS | 14856 | 02:32:13 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-oscillator) 02:32:13 INFO - PROCESS | 14856 | RSS: Main: 181555200 02:32:13 INFO - PROCESS | 14856 | 02:32:16 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:16 INFO - PROCESS | 14856 | RSS: Main: 185876480 02:32:16 INFO - PROCESS | 14856 | 02:32:19 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:20 INFO - PROCESS | 14856 | RSS: Main: 222629888 02:32:20 INFO - PROCESS | 14856 | 02:32:24 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:24 INFO - PROCESS | 14856 | RSS: Main: 217944064 02:32:24 INFO - PROCESS | 14856 | 02:32:27 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43926/tests/kraken/driver.html?testName=json-parse-financial) 02:32:28 INFO - PROCESS | 14856 | RSS: Main: 221065216 02:32:28 INFO - PROCESS | 14856 | 02:32:29 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:30 INFO - PROCESS | 14856 | RSS: Main: 212086784 02:32:30 INFO - PROCESS | 14856 | 02:32:32 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:32 INFO - PROCESS | 14856 | RSS: Main: 215834624 02:32:32 INFO - PROCESS | 14856 | 02:32:35 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:32:35 INFO - PROCESS | 14856 | RSS: Main: 212082688 02:32:35 INFO - PROCESS | 14856 | 02:32:38 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:39 INFO - PROCESS | 14856 | RSS: Main: 226070528 02:32:39 INFO - PROCESS | 14856 | 02:32:42 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:42 INFO - PROCESS | 14856 | RSS: Main: 225079296 02:32:42 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43926/tests/kraken/driver.html?testName=ai-astar) 02:32:44 INFO - PROCESS | 14856 | RSS: Main: 267026432 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | __start_tp_report 02:32:44 INFO - PROCESS | 14856 | _x_x_mozilla_page_load 02:32:44 INFO - PROCESS | 14856 | _x_x_mozilla_page_load_details 02:32:44 INFO - PROCESS | 14856 | |i|pagename|runs| 02:32:44 INFO - PROCESS | 14856 | |0;ai-astar;105;116;117;114;115;115;114;115;116;113 02:32:44 INFO - PROCESS | 14856 | |1;audio-beat-detection;157;129;128;192;131;123;147;122;161;127 02:32:44 INFO - PROCESS | 14856 | |2;audio-dft;160;162;161;161;161;159;161;162;162;161 02:32:44 INFO - PROCESS | 14856 | |3;audio-fft;75;75;76;110;75;76;75;75;98;76 02:32:44 INFO - PROCESS | 14856 | |4;audio-oscillator;85;86;121;85;85;85;125;85;85;119 02:32:44 INFO - PROCESS | 14856 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 02:32:44 INFO - PROCESS | 14856 | |6;imaging-darkroom;147;146;146;146;147;145;146;147;146;147 02:32:44 INFO - PROCESS | 14856 | |7;imaging-desaturate;95;96;95;95;95;95;94;95;95;94 02:32:44 INFO - PROCESS | 14856 | |8;json-parse-financial;65;64;62;63;63;64;64;64;62;71 02:32:44 INFO - PROCESS | 14856 | |9;json-stringify-tinderbox;66;65;66;66;66;65;66;67;67;65 02:32:44 INFO - PROCESS | 14856 | |10;stanford-crypto-aes;79;81;79;84;80;79;79;78;85;83 02:32:44 INFO - PROCESS | 14856 | |11;stanford-crypto-ccm;137;138;128;130;141;128;131;135;169;141 02:32:44 INFO - PROCESS | 14856 | |12;stanford-crypto-pbkdf2;165;164;164;162;163;170;164;163;174;164 02:32:44 INFO - PROCESS | 14856 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;66;70;66;64;65 02:32:44 INFO - PROCESS | 14856 | __end_tp_report 02:32:44 INFO - PROCESS | 14856 | __start_cc_report 02:32:44 INFO - PROCESS | 14856 | _x_x_mozilla_cycle_collect,1934 02:32:44 INFO - PROCESS | 14856 | __end_cc_report 02:32:44 INFO - PROCESS | 14856 | __startTimestamp1468920764659__endTimestamp 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | ------- Summary: start ------- 02:32:44 INFO - PROCESS | 14856 | Number of tests: 14 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.37 (2.9%) stddev-sans-first:1.22 02:32:44 INFO - PROCESS | 14856 | Values: 105.0 116.0 117.0 114.0 115.0 115.0 114.0 115.0 116.0 113.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:139.00 stddev:22.56 (16.2%) stddev-sans-first:23.24 02:32:44 INFO - PROCESS | 14856 | Values: 157.0 129.0 128.0 192.0 131.0 123.0 147.0 122.0 161.0 127.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:32:44 INFO - PROCESS | 14856 | Values: 160.0 162.0 161.0 161.0 161.0 159.0 161.0 162.0 162.0 161.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:12.40 (16.4%) stddev-sans-first:12.96 02:32:44 INFO - PROCESS | 14856 | Values: 75.0 75.0 76.0 110.0 75.0 76.0 75.0 75.0 98.0 76.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:17.70 (20.8%) stddev-sans-first:18.32 02:32:44 INFO - PROCESS | 14856 | Values: 85.0 86.0 121.0 85.0 85.0 85.0 125.0 85.0 85.0 119.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:32:44 INFO - PROCESS | 14856 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:32:44 INFO - PROCESS | 14856 | Values: 147.0 146.0 146.0 146.0 147.0 145.0 146.0 147.0 146.0 147.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:32:44 INFO - PROCESS | 14856 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.57 (4.0%) stddev-sans-first:2.71 02:32:44 INFO - PROCESS | 14856 | Values: 65.0 64.0 62.0 63.0 63.0 64.0 64.0 64.0 62.0 71.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 02:32:44 INFO - PROCESS | 14856 | Values: 66.0 65.0 66.0 66.0 66.0 65.0 66.0 67.0 67.0 65.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.45 (3.0%) stddev-sans-first:2.52 02:32:44 INFO - PROCESS | 14856 | Values: 79.0 81.0 79.0 84.0 80.0 79.0 79.0 78.0 85.0 83.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:12.03 (8.7%) stddev-sans-first:12.75 02:32:44 INFO - PROCESS | 14856 | Values: 137.0 138.0 128.0 130.0 141.0 128.0 131.0 135.0 169.0 141.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:164.00 stddev:3.74 (2.3%) stddev-sans-first:3.97 02:32:44 INFO - PROCESS | 14856 | Values: 165.0 164.0 164.0 162.0 163.0 170.0 164.0 163.0 174.0 164.0 02:32:44 INFO - PROCESS | 14856 | 02:32:44 INFO - PROCESS | 14856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.58 (2.4%) stddev-sans-first:1.66 02:32:44 INFO - PROCESS | 14856 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 70.0 66.0 64.0 65.0 02:32:44 INFO - PROCESS | 14856 | -------- Summary: end -------- 02:32:44 INFO - PROCESS | 14856 | 02:32:45 INFO - TEST-INFO | 14856: exit 0 02:32:45 INFO - TEST-OK | kraken | took 63008ms 02:32:45 INFO - SUITE-END | took 1182s 02:32:45 INFO - Completed test suite (00:19:42) 02:32:45 INFO - javascript benchmark 02:32:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.9606705899405, 2627.3956989892326, 2669.7196794336583, 2678.142994241842, 2678.142994241842, 4591.24244499658, 4640.118377508271, 4716.589988360881, 4783.832565860192, 4827.227643577024, 4678.929816052753, 4721.480637129922, 4732.455767586728, 4734.337192793012, 4738.076075165344, 4121.670266378683, 4299.699021068519, 4389.078293558357, 4419.116176764644, 4457.286834106543, 4357.41174941382, 4401.3397990301555, 4413.139437809628, 4425.31407631816, 4454.443194600675, 4268.231718290706, 4323.113761678848, 4338.479382474124, 4356.194104090753, 4391.341298805205, 4291.914161716748, 4296.957030429687, 4298.118885628439, 4355.934660980088, 4374.103308821684, 4323.200207961506, 4340.913181736348, 4357.324614684697, 4381.298992161271, 4402.8679139625865, 4577.359169716243, 4629.143608432417, 4678.625709943196, 4695.084458530588, 4699.060187962421, 5074.31496747938, 5098.719570423626, 5133.820316288912, 5146.279520867044, 5148.716820574867, 5144.305518754958, 5158.0, 5173.637845350827, 5182.041322355376, 5183.170692689152, 4583.587477127075, 4664.300354946785, 4782.067496838084, 4791.113643975876, 4862.3922009748785, 5285.524302812765, 5295.629305948623, 5319.882824606799, 5321.5476684482255, 5324.387695414999, 4840.0, 5087.669301495391, 5095.210242412432, 5095.363079615048, 5097.057044446789, 5057.266696329012, 5097.1844504879045, 5112.71880046601, 5116.079105760924, 5137.101007323703, 5086.415062267813, 5093.871202528485, 5094.083065048253, 5106.234064890222, 5147.253648220987, 4857.319975203474, 4896.363472748591, 5070.442251352349, 5075.746212689351, 5086.440491545927, 4325.7188282762145, 4371.169477799208, 4373.715708478939, 4385.473743150842, 4398.8020539075815, 3786.2238241160494, 3799.3920972644796, 3811.5045044144085, 3840.577536470986, 3841.519810023747, 4290.742555446621, 4386.517483076859, 4397.73613583186, 4444.533324000933, 4446.3108218226225, 5061.620378471629, 5112.207607820794, 5125.15434953236, 5177.508136727005, 5197.688138711689, 4412.492563355255, 4419.9779001105435, 4423.270160423494, 4423.756693381895, 4463.464384273908, 4646.233371493666, 4655.255159174516, 4660.067986402733, 4661.091087238024, 4701.576858082721, 4636.744979026186, 4786.329913812138, 4830.0, 4836.903261934812, 4847.951520484891, 5150.742462876916, 5159.793608255778, 5159.974200128975, 5160.0, 5209.322788037531, 4680.976595117003, 4806.0, 4839.249916262844, 4854.05345957549, 4899.902001960012, 5011.473795251446, 5063.924041139312, 5066.265391518135, 5072.416672082758, 5086.364204474441, 5147.819826306061, 5166.4058633257655, 5167.062715148937, 5168.689878607295, 5219.556337711337, 4811.0, 4969.403671559291, 5007.123753343223, 5018.021485810232, 5018.071656743514, 5004.174311238605, 5035.697858128524, 5055.292259083805, 5059.544640982329, 5101.489851015017, 4961.181405068123, 4969.801207951641, 5018.4730603286125, 5020.297158397754, 5028.59771218309, 4834.3231947528075, 4942.986687729079, 5005.074061298671, 5060.620453466078, 5070.062038522885, 4896.143174944299, 4910.803567857246, 4916.06594746997, 4916.188828843201, 4949.777260023236], "value": 4689.173882940797, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.8709370842046, 583.4602992232184, 596.3738075021228, 599.6402158704775, 603.2429301226958, 26084.0, 38176.236475270474, 39229.0, 39300.0, 39353.21293574131, 39378.606213937856, 39684.80157599208, 39777.20445591086, 39787.0, 39801.40297895534, 7841.607919604011, 7850.528968261894, 7940.444168908179, 7959.840803183933, 7971.840563188733, 7803.960980195091, 7863.803404914895, 7869.645865936047, 9978.90021099787, 10254.384736915772, 10359.482025898713, 10422.114120299746, 10424.166066714644, 10425.79148417035, 10428.0, 10079.596816127383, 10133.0, 10180.949095254551, 10187.79624407515, 10216.540255688511, 7631.961840190819, 9820.508974551316, 10228.948855255676, 10231.795364092677, 10610.522526486327, 38692.22615547673, 38859.8057009716, 38983.8050809747, 39026.41460378097, 39031.024224394336, 3120.625524936999, 3164.2247649326064, 3193.379651812803, 3219.5331676906953, 3734.9626503734885, 28656.283592910346, 29047.12858614245, 29150.27124321888, 29220.415591688048, 30007.849960750274, 3251.707346338841, 3364.4280472319765, 3391.084407210064, 3422.7946323220685, 3552.2540266544056, 157839.0, 159153.99999999884, 160068.0, 161407.0, 161669.0, 53120.734396327774, 53681.0, 53761.731191343795, 53810.461895381326, 53993.46006539963, 32856.178595534824, 33673.83163084218, 33675.32649346999, 35291.117722057155, 56805.431945680844, 15239.695206096038, 15372.308246128727, 15406.22968851553, 15410.845891541165, 15438.0, 10615.946920265504, 10939.617113400993, 10968.451577421256, 11006.449677516091, 11013.83479247812, 17615.735763963552, 18051.187696553687, 18378.0, 18921.81078189228, 19029.61940761177, 6576.375244351779, 6784.660766961632, 6915.619640919797, 7035.7185712571945, 7055.753048643272, 742.8514297140485, 785.3246208260891, 892.4912799704236, 902.3638334973828, 983.9029482127377, 27441.86279068632, 27524.862375687993, 27750.3062423437, 27806.165815025583, 27886.581701274496, 934.0146145816093, 937.2174234514257, 993.215359865698, 1020.336781092296, 1078.5793540519203, 14312.0, 14726.337314820645, 14849.406023759144, 14912.84763997586, 14981.176035317943, 125516.37241813733, 125718.0, 125929.37035314948, 126027.0, 127376.36311818568, 48276.5172348279, 48673.26990095151, 48685.0, 48704.51295487, 48789.5121048785, 1085.4898197846999, 1168.7720894425506, 1172.7302720374532, 1181.8109102543551, 1190.1490434339316, 27211.319717007234, 28510.019343906602, 28527.0, 28783.5682464759, 28888.566671500364, 40665.0, 40897.38653920253, 41161.0, 41165.0, 41297.587024130575, 290751.0, 292010.0, 292406.0, 292434.0, 292966.0, 22074.558508830054, 24292.392690182885, 24897.377565561004, 25077.122300719388, 26194.73805261923, 40146.39780403238, 40746.38880416737, 40801.0, 41614.791926041384, 42045.57954420416, 34593.30813383769, 34874.65125348714, 34928.65071349254, 35833.82083089568, 35866.82066589755, 34864.0, 35401.46897796483, 35792.64207357893, 35808.28383432265, 36204.09489762777, 31271.374572508877, 31911.6808831918, 32116.19709507281, 32185.839070804497, 34914.0, 30026.0, 32053.839730801195, 32594.51108233426, 32775.34449310953, 32818.0, 24446.511069778862, 24826.0, 24922.87538562368, 25202.0, 25246.0], "value": 16865.7039566657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.2100986216909, 365.85731564689775, 369.1251733391862, 374.74891822478946, 384.45215567815853, 13117.0, 16316.184190790458, 16736.748948765777, 17898.463046108605, 17911.462656120304, 15921.0, 15968.520944371687, 16452.83547164528, 17262.136893155355, 17589.296428142858, 4448.243798554237, 5216.3218781558435, 5324.600654950875, 5325.547328477084, 5333.546648534879, 3777.0934975605796, 3992.500937382827, 5970.641761494303, 6261.279952805417, 6277.748890044393, 5160.612954028444, 6282.905756413657, 6311.968440157816, 6322.336154703758, 6331.77838775643, 5432.837014889559, 5446.373667028263, 5454.7272636368225, 5475.890482190334, 5476.151196564539, 4713.882152946169, 4994.051130285234, 5276.841694749163, 5290.523852853224, 5293.23248129023, 12356.25862448247, 12489.50041998328, 12627.305498197595, 12720.809187862189, 12734.554290599877, 1815.5370380553006, 1821.717633766755, 1835.7613510243716, 1839.9264029438807, 1861.6183682345086, 8963.14850089247, 10407.68776936693, 12771.425285862066, 13349.799753003712, 13589.932050339783, 1682.0412364951983, 1691.534827922319, 1707.795064592257, 1714.3913910561696, 1769.6106856491551, 62357.68821155865, 68020.6598967002, 68852.3114768851, 69256.0, 70524.6473767633, 9415.199708024895, 9604.471754053595, 9829.606815727433, 10026.548805303779, 10137.645182418728, 13747.0, 13841.100328478617, 13849.238291894042, 13852.09961352529, 13857.307134643228, 6864.347886950732, 6894.482913781487, 6928.584284942919, 7027.5080744348425, 7041.753538626123, 6523.836904077341, 6542.967285163639, 6626.304238054935, 6645.867082658319, 6666.033425153326, 4280.636145927631, 4300.419443375167, 4358.5205627380965, 4374.715643483163, 4460.977695111504, 1678.5971366871863, 1720.1227374039079, 1825.2425243524053, 1839.4297767691792, 1887.6319117771902, 831.6881169561415, 841.3227351981714, 882.5454890731279, 947.4836214263244, 971.820213260549, 16615.41846035383, 16748.497545073424, 17028.829711702972, 17349.653006940043, 17511.73732394015, 823.1398188892622, 828.2504333578122, 851.9233269005696, 891.460666296894, 909.3225546967551, 9254.259659227246, 9677.129058384779, 9744.610215591298, 9752.463614501128, 9900.108990190918, 368128.0, 371341.0, 373176.0, 373663.0, 379180.0, 57910.7104464475, 74305.0, 74321.25678743252, 74903.25096749072, 76562.61718691482, 840.9404150770074, 853.5732133933034, 858.2275951643446, 880.3793325705362, 887.6094518411878, 14088.577342679737, 15038.774418383951, 15456.459023934109, 15468.14925179081, 15469.5359139226, 35699.64300356963, 36779.26441471209, 36893.0, 36938.81530592437, 37086.44370334501, 46754.0, 47936.56190314296, 48336.98675281741, 49286.26070609016, 55770.72114639401, 7590.734324298623, 7686.730964416219, 7781.844363112819, 7890.723824666109, 7984.600769961363, 10424.68725938223, 12044.518219271482, 12105.0, 12131.514739410324, 12165.69585760363, 10397.11624511925, 10545.894541054491, 10553.153198190439, 10769.192310576582, 10826.512806923865, 10156.289059765746, 10659.626913058317, 10726.141908647445, 10979.945100274766, 11114.0, 10433.634822781167, 10461.163106951577, 10463.68608941733, 10467.057964783206, 10528.94735526348, 7569.735059272899, 7728.188540203422, 7776.7278145264645, 7780.183080776664, 8035.477693949874, 10101.898981010096, 10227.7443063924, 10272.435016074187, 10279.794404111726, 10474.0], "value": 8096.170019458958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.9862601373986, 1407.1135184833554, 1495.192595998161, 1676.0530300380276, 1712.4605749189013, 7397.2602739726, 7872.0947091084545, 7925.524468531892, 7951.562664053475, 7953.681852725891, 6629.3370662933685, 6844.349786770262, 7438.4793064485375, 7677.808054798619, 7686.807829804244, 2183.6178668732946, 2207.602631526325, 2210.35899589119, 2211.4360837986374, 2214.30249471416, 1841.116264193188, 2174.0, 2187.55155193185, 2193.166596693254, 2204.041242059709, 2103.957920841582, 2161.3083813179787, 2170.468235282358, 2188.391532223814, 2195.264586363562, 2185.7049298344677, 2198.6482162853868, 2207.558488302346, 2220.3449982255274, 2233.129079658934, 2193.638049721794, 2194.5501172259646, 2201.5266717655622, 2201.5486825200796, 2202.559488102386, 7951.761447156595, 7996.680132794681, 7997.080335761346, 8002.759917202493, 8010.639521221559, 4642.582167604932, 4741.691790033637, 4800.135975524404, 4804.303376010494, 4812.085703716318, 2814.2925719938103, 2902.680705122435, 2939.456200602874, 2941.5734718465915, 2970.6880777518268, 896.2247655777705, 907.2968449451662, 912.6668765900465, 917.9495127767971, 921.9078092190795, 10603.469826508644, 10621.787564248749, 10624.309419887682, 10649.148068154607, 10669.199810014203, 4114.6091121343425, 4255.787210639455, 4357.847475338412, 4370.8907277317685, 4392.604665580113, 9118.088191180961, 9179.908200918038, 9179.954100229455, 9185.081491850895, 9190.724278271662, 4810.11012962603, 4811.182099043171, 4811.230203167476, 4812.085703716282, 4816.54242846929, 4288.699791014599, 4337.219300525936, 4377.518472967971, 4388.363687265392, 4395.7362558246605, 3668.669819716185, 3711.4432835074954, 3750.5499340079364, 3763.473113764075, 3806.0865392305645, 1103.1064837481665, 1195.49789088583, 1208.4380762945273, 1212.630147804928, 1233.802591585342, 862.7886167888907, 867.2974890338845, 877.863931090682, 886.6483801616106, 905.8505346617734, 5353.250544923714, 5395.946040539623, 5568.387477377485, 5610.242617246701, 5660.320761508563, 905.5879574793453, 907.1155623267261, 921.2906062331967, 938.3572253006575, 969.520087556664, 3419.350323438539, 3596.1369271374683, 3681.079730067483, 3684.09739613791, 3687.465317528943, 9488.240940724725, 9623.759406014906, 9629.951850240705, 9699.612015519442, 9793.412395256308, 9479.0, 9739.513024348755, 9755.317127801127, 9761.463119528495, 9765.755856103655, 7004.684789184397, 7218.927810721931, 7346.11846578414, 7353.77938661841, 7362.226966168582, 5412.161115027177, 5422.457754224703, 5506.394296627288, 5523.895220955745, 5614.0, 8990.056044115274, 9133.40632858862, 9188.540572971191, 9192.35653504275, 9223.216026637543, 8716.912830871865, 8978.640854365753, 8986.82026359456, 9019.639214431349, 9232.907670923205, 7193.928060719326, 7284.890726639211, 7298.051253337032, 7421.2949769771785, 7479.775606731807, 7452.515586486861, 7525.736599219001, 7526.209747976383, 7528.548287102572, 7543.434242431949, 6731.730730770714, 6748.460123190232, 6843.315668433117, 6890.586564806128, 6918.0314755935215, 6614.074029635759, 6618.470522358296, 6673.566218195801, 6796.66016699173, 6801.353871382211, 6537.444317232898, 6585.901211481927, 6595.472362210916, 6604.735810567716, 6634.303398143125, 4660.650451216105, 4677.368555244999, 4719.457262414866, 4732.834350797705, 4779.617630589614, 4719.05618876233, 4791.664583479263, 4819.903601928012, 4840.2255639097575, 4841.927371089507], "value": 4217.887211213373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.0516833212888, 295.11171374163763, 301.9048999565137, 304.6100990731864, 304.6800859097947, 4799.5680388765, 4813.181759100952, 4835.419749630045, 4846.764075160833, 4856.660033797635, 4769.809207631691, 4770.5670108244785, 4770.950390914002, 4772.635292119056, 4799.496052914446, 3600.3519366514083, 3726.6273372662786, 3731.7014638828828, 3779.0, 3797.126660868002, 3768.321702093622, 3797.411401232813, 3808.5239345081864, 3809.314323421797, 3810.247286248329, 3777.452269420932, 3780.017195529155, 3787.110029143149, 3798.1454172811173, 3799.4300854871854, 3590.4434812604086, 3665.395209790368, 3740.1673180141806, 3779.1496913194587, 3784.2053168834577, 3335.366280406715, 3336.182635254354, 3344.2976974835315, 3354.228527438678, 3356.2280675444786, 4650.18621741194, 4651.3023046543285, 4666.789994450224, 4682.6253899687945, 4692.694974826625, 4172.3532852407925, 4321.416608757809, 4335.436393268855, 4349.195398851222, 4355.782210889474, 5004.399472063339, 5014.749262536895, 5022.869854282793, 5030.647854650176, 5030.84907452777, 3673.1716578234877, 3680.1535646801385, 3687.8340474678703, 3689.8524059037604, 3703.3148867459604, 5103.923441148386, 5230.861483110103, 5258.6318957672975, 5296.602754793367, 5303.064381500763, 3774.7735135891935, 3781.773093614392, 3784.299904517673, 3786.2995345861104, 3790.1851102012647, 3824.623135671156, 3826.0, 3833.9424908626393, 3844.1735026969336, 3851.691864650821, 4305.677074219383, 4307.0, 4312.072904325585, 4323.524412314643, 4326.610605045561, 4872.123017856749, 5032.572231360376, 5040.596752259884, 5056.595472362203, 5076.36545431821, 1321.6167311479562, 1333.639917222364, 1335.1988806715892, 1340.8189894364332, 1344.764666183414, 843.355456859115, 861.4443683823898, 870.2950610005915, 876.912308769118, 885.2121611765534, 4378.408914796525, 4453.51011388747, 4479.238529450001, 4505.707129036602, 4512.503624601291, 5207.895842083213, 5212.087884620252, 5213.947860521422, 5228.529432351031, 5231.921521177185, 4485.730856148642, 4494.438195225597, 4501.347304640874, 4501.392312037833, 4506.211413002711, 2608.2957601447883, 2793.9022134225206, 2798.958015629767, 2799.174243598143, 2807.764583583217, 4959.008198360342, 4963.677360971526, 4972.378452693413, 4979.626528010342, 4979.825706100269, 5236.554892834076, 5339.46605339463, 5397.055515284809, 5398.109311963561, 5404.54061404785, 4950.752462376939, 4971.304017437562, 4971.925421118686, 4974.676646017997, 4985.401751789808, 5237.590708274084, 5264.78940842362, 5266.55234305073, 5275.314209152785, 5283.735813209248, 5007.974960125176, 5110.642255042111, 5164.664296820694, 5180.585553155664, 5184.174624829552, 4907.263910413467, 4939.53074457926, 4965.18074517715, 4972.3535940328975, 4980.850574482772, 3406.7444941628983, 3407.0, 3413.5050417689795, 3419.26485805553, 3425.6574342565546, 4636.235021221595, 4640.978984623377, 4654.581087702123, 4665.4634717007975, 4893.853184404474, 5050.823221187241, 5063.721495317645, 5106.846794596168, 5111.79552817898, 5115.411727651219, 5031.547160755403, 5038.697678139177, 5054.974725126351, 5078.542931136068, 5092.701361152882, 4826.348442960156, 5018.372703412074, 5019.472955339636, 5020.121478741133, 5045.217991211368, 4843.612510999182, 4975.0, 5097.8725531862, 5099.628672667228, 5111.718855462986, 4955.72743499111, 4993.0, 4995.300657907968, 5019.322391477104, 5025.271335656236], "value": 3816.4000817386996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9195508606339, 663.9601623902569, 689.1076056506823, 701.2251462134342, 727.6652739739719, 12083.395830208487, 12757.107002509829, 12758.234505929651, 12824.294663793487, 12849.164804287726, 11723.648290551277, 11729.178957472981, 11735.29588224705, 11746.823797643043, 11899.286042837435, 619.3929948650325, 753.5892938348586, 765.4832987733286, 776.1268572855538, 778.8636988527013, 772.4052479590712, 775.0196002057402, 775.9340456061213, 776.6272189349088, 779.2246714519061, 816.9264766171043, 818.5620692929284, 818.6684392820918, 818.7175424478545, 819.4141189049828, 644.2784081828336, 658.713459645056, 661.5137873662854, 664.6344510519243, 810.8297257575887, 577.2582231832075, 591.6804925340311, 595.4730063893486, 596.1534620838377, 597.1818608506375, 12999.960003199722, 13006.479740810357, 13021.479140834355, 13026.218426894417, 13060.0, 11912.642620721392, 12188.573399931049, 12279.91241488949, 12293.385330733518, 12599.93700031503, 11104.888951110546, 11242.213045086848, 11257.71855703614, 11427.48576314068, 11626.651200463999, 4128.071183983609, 4182.414461975326, 4193.97903010483, 4243.766592837393, 4322.243607368698, 57830.0, 57924.0, 59201.7039914802, 59986.40013599852, 60088.399116009154, 9717.902820971842, 9797.951010244904, 9824.263180261509, 9918.30571859963, 9949.502524873873, 17924.103794810206, 17971.550711232063, 18007.369742058963, 18069.7289540657, 18088.00515971634, 6918.481113916477, 6965.686544105527, 7007.229204787469, 7070.858582828315, 7250.16623088341, 3488.0582242794812, 3547.822608869546, 3579.4093974493917, 3586.1572530455323, 3595.7662751921566, 2777.291790593386, 2852.8430936298287, 2879.424115176973, 2880.2943278896387, 2880.5967164596973, 507.2214151277771, 507.33032397235297, 516.032439176544, 528.6246764797037, 530.6815910453774, 430.6877513802531, 466.89494863655403, 520.0950346397242, 529.8569386265686, 564.4496615799562, 7509.887351689729, 7623.504472209289, 7666.198851364143, 7751.0, 7798.181190974866, 524.5698527207729, 541.775163307231, 545.476342710994, 559.6683446846281, 579.4090028171325, 3717.8698745544316, 3722.7952462614276, 3735.701143908481, 3758.3047136279874, 3832.865849695247, 91280.54359728159, 91721.0, 95140.52429737807, 95163.0, 95420.0, 46942.76528617335, 64836.0, 74461.0, 77765.83351249735, 81191.5940420294, 45273.547264527595, 71842.64078679678, 73646.26353736501, 73728.0, 75173.0, 8596.828063438572, 9109.817803644022, 9208.723738287863, 9217.354785164975, 9385.624575017197, 42365.78817105895, 43979.560204398826, 44345.77827110844, 45525.54474455213, 45632.31551526664, 62360.68819655872, 63461.0, 63565.6821715907, 63631.68184159049, 63817.0, 10608.575656973635, 11368.715782105513, 11474.368909709712, 11589.420528973349, 12033.63899083029, 11227.326360418401, 11410.201285910238, 11735.0, 11762.411879406167, 11794.823077654013, 10790.244682872124, 10892.40091794959, 11155.27490713101, 11198.664040078811, 11454.0, 10179.898201018192, 10364.170866330825, 10501.422421766876, 10591.89408105909, 10747.677569672922, 12127.151099422956, 12180.634580962585, 12367.134300598871, 12432.378381081091, 12809.654986226686, 9518.571664274985, 9557.187639050759, 9560.904390956, 9880.061394167542, 9911.0, 8949.194572488508, 9618.759531011781, 9730.0, 9898.257630677585, 10024.799504010025], "value": 6374.863396237454, "unit": "score"}], "name": "dromaeo_css", "value": 6352.448349127439, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 117.0, 114.0, 115.0, 115.0, 114.0, 115.0, 116.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 128.0, 192.0, 131.0, 123.0, 147.0, 122.0, 161.0, 127.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 75.0, 76.0, 75.0, 75.0, 98.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 121.0, 85.0, 85.0, 85.0, 125.0, 85.0, 85.0, 119.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 63.0, 63.0, 64.0, 64.0, 64.0, 62.0, 71.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 84.0, 80.0, 79.0, 79.0, 78.0, 85.0, 83.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 128.0, 130.0, 141.0, 128.0, 131.0, 135.0, 169.0, 141.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 162.0, 163.0, 170.0, 164.0, 163.0, 174.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 70.0, 66.0, 64.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1532.2, "alertThreshold": 2.0}]} 02:32:45 INFO - Return code: 0 02:32:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:32:45 INFO - # TBPL SUCCESS # 02:32:45 INFO - Running post-action listener: _resource_record_post_action 02:32:45 INFO - ##### 02:32:45 INFO - ##### Finished run-tests step (success) 02:32:45 INFO - ##### 02:32:45 INFO - Running post-run listener: _resource_record_post_run 02:32:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536006656; Read time: 8; Write time: 380936 02:32:46 INFO - TinderboxPrint: CPU usage
13.0% 02:32:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:32:46 INFO - TinderboxPrint: I/O write bytes / time
536,006,656 / 380,936 02:32:46 INFO - TinderboxPrint: CPU idle
8,327.6 (87.0%) 02:32:46 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 02:32:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:32:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246988800; Read time: 0; Write time: 240240 02:32:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 289017856; Read time: 0; Write time: 140696 02:32:46 INFO - Running post-run listener: _upload_blobber_files 02:32:46 INFO - Blob upload gear active. 02:32:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:32:46 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 02:32:46 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'] 02:32:46 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 02:32:46 INFO - (blobuploader) - INFO - Open directory for files ... 02:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:52 INFO - (blobuploader) - INFO - Done attempting. 02:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:32:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:53 INFO - (blobuploader) - INFO - Done attempting. 02:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:32:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:53 INFO - (blobuploader) - INFO - Done attempting. 02:32:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:32:53 INFO - Return code: 0 02:32:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:32:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:32:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d39bc5bc99f0a157954e31a5f89970f3d0f5c71d169c5fba79a099369cde56dc4751373be1094a2806e7ed47ae8485f01fc644cf14dfdf4531bb3cf6a905d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a501fd34815fbfbc8cc359714f85aa13af17855e90b297d78e70a07a24620ba85869d19584ceeeed50fa2d583814a91ae43359fee6037bd404399de0e1739d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd649af79857a56af5372a31b58957a0a402fed2e771f38da14e7cc8a0f6b46056248dd72db459c21305ccdbefd44aa29c014d6418e02bd9ecd7e2cc9b3a30b5"} 02:32:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:32:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:32:53 INFO - Contents: 02:32:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d39bc5bc99f0a157954e31a5f89970f3d0f5c71d169c5fba79a099369cde56dc4751373be1094a2806e7ed47ae8485f01fc644cf14dfdf4531bb3cf6a905d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a501fd34815fbfbc8cc359714f85aa13af17855e90b297d78e70a07a24620ba85869d19584ceeeed50fa2d583814a91ae43359fee6037bd404399de0e1739d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd649af79857a56af5372a31b58957a0a402fed2e771f38da14e7cc8a0f6b46056248dd72db459c21305ccdbefd44aa29c014d6418e02bd9ecd7e2cc9b3a30b5"} 02:32:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:32:53 INFO - Copying logs to upload dir... 02:32:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:32:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.479071 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-19 02:32:53.614432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:32:53.617774) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d39bc5bc99f0a157954e31a5f89970f3d0f5c71d169c5fba79a099369cde56dc4751373be1094a2806e7ed47ae8485f01fc644cf14dfdf4531bb3cf6a905d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a501fd34815fbfbc8cc359714f85aa13af17855e90b297d78e70a07a24620ba85869d19584ceeeed50fa2d583814a91ae43359fee6037bd404399de0e1739d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd649af79857a56af5372a31b58957a0a402fed2e771f38da14e7cc8a0f6b46056248dd72db459c21305ccdbefd44aa29c014d6418e02bd9ecd7e2cc9b3a30b5"} build_url:https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/NRZj8GBLQA6o_wTGaTM6SA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d39bc5bc99f0a157954e31a5f89970f3d0f5c71d169c5fba79a099369cde56dc4751373be1094a2806e7ed47ae8485f01fc644cf14dfdf4531bb3cf6a905d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a501fd34815fbfbc8cc359714f85aa13af17855e90b297d78e70a07a24620ba85869d19584ceeeed50fa2d583814a91ae43359fee6037bd404399de0e1739d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd649af79857a56af5372a31b58957a0a402fed2e771f38da14e7cc8a0f6b46056248dd72db459c21305ccdbefd44aa29c014d6418e02bd9ecd7e2cc9b3a30b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:32:53.642695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:32:53.643028) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468919319.608319-2019084581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:32:53.726296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:32:53.726634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:32:53.726939) ========= ========= Total master_lag: 0.16 =========