builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1467291273.4 results: success (0) buildid: 20160630051527 builduid: 470f8419c3fa49e697b84b392c57da64 revision: 7940be96e124a4f6b812d2b3ad6762f2921be04b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.403596) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.404079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.404421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.420087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.420542) ========= 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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-30 05:54:33 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.527944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.528395) ========= 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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019722 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.578229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:33.578598) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7940be96e124a4f6b812d2b3ad6762f2921be04b --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 7940be96e124a4f6b812d2b3ad6762f2921be04b --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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:54:33,860 truncating revision to first 12 chars 2016-06-30 05:54:33,860 Setting DEBUG logging. 2016-06-30 05:54:33,860 attempt 1/10 2016-06-30 05:54:33,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7940be96e124?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:54:34,504 unpacking tar archive at: fx-team-7940be96e124/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:34.557702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:34.558036) ========= script_repo_revision: 7940be96e124a4f6b812d2b3ad6762f2921be04b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:34.558472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:34.558744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:54:34.568531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-30 05:54:34.568922) ========= /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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:34 INFO - MultiFileLogger online at 20160630 05:54:34 in /builds/slave/test 05:54:34 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 05:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:34 INFO - {'append_to_log': False, 05:54:34 INFO - 'base_work_dir': '/builds/slave/test', 05:54:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:34 INFO - 'branch': 'Fx-Team-Non-PGO', 05:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:34 INFO - 'config_files': ('talos/linux_config.py',), 05:54:34 INFO - 'default_actions': ('clobber', 05:54:34 INFO - 'read-buildbot-config', 05:54:34 INFO - 'download-and-extract', 05:54:34 INFO - 'populate-webroot', 05:54:34 INFO - 'create-virtualenv', 05:54:34 INFO - 'install', 05:54:34 INFO - 'run-tests'), 05:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:34 INFO - 'download_minidump_stackwalk': True, 05:54:34 INFO - 'download_symbols': 'ondemand', 05:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:34 INFO - 'installer_path': 'installer.exe', 05:54:34 INFO - 'log_level': 'info', 05:54:34 INFO - 'log_name': 'talos', 05:54:34 INFO - 'log_to_console': True, 05:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:34 INFO - 'opt_config_files': (), 05:54:34 INFO - 'pip_index': False, 05:54:34 INFO - 'sps_profile': False, 05:54:34 INFO - 'sps_profile_interval': 0, 05:54:34 INFO - 'suite': 'dromaeojs', 05:54:34 INFO - 'system_bits': '32', 05:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:34 INFO - 'title': 'talos-linux64-ix-063', 05:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:34 INFO - 'use_talos_json': True, 05:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:34 INFO - 'work_dir': 'build'} 05:54:34 INFO - ##### 05:54:34 INFO - ##### Running clobber step. 05:54:34 INFO - ##### 05:54:34 INFO - Running pre-action listener: _resource_record_pre_action 05:54:34 INFO - Running main action method: clobber 05:54:34 INFO - rmtree: /builds/slave/test/build 05:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:35 INFO - Running post-action listener: _resource_record_post_action 05:54:35 INFO - ##### 05:54:35 INFO - ##### Finished clobber step (success) 05:54:35 INFO - ##### 05:54:35 INFO - ##### 05:54:35 INFO - ##### Running read-buildbot-config step. 05:54:35 INFO - ##### 05:54:35 INFO - Running pre-action listener: _resource_record_pre_action 05:54:35 INFO - Running main action method: read_buildbot_config 05:54:35 INFO - Using buildbot properties: 05:54:35 INFO - { 05:54:35 INFO - "project": "", 05:54:35 INFO - "product": "firefox", 05:54:35 INFO - "script_repo_revision": "production", 05:54:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:54:35 INFO - "repository": "", 05:54:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:54:35 INFO - "buildid": "20160630051527", 05:54:35 INFO - "pgo_build": "False", 05:54:35 INFO - "basedir": "/builds/slave/test", 05:54:35 INFO - "buildnumber": 1786, 05:54:35 INFO - "slavename": "talos-linux64-ix-063", 05:54:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:54:35 INFO - "platform": "ubuntu64_hw", 05:54:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:54:35 INFO - "branch": "fx-team", 05:54:35 INFO - "repo_path": "integration/fx-team", 05:54:35 INFO - "revision": "7940be96e124a4f6b812d2b3ad6762f2921be04b", 05:54:35 INFO - "stage_platform": "linux64", 05:54:35 INFO - "builduid": "470f8419c3fa49e697b84b392c57da64", 05:54:35 INFO - "slavebuilddir": "test" 05:54:35 INFO - } 05:54:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:54:35 INFO - Running post-action listener: _resource_record_post_action 05:54:35 INFO - ##### 05:54:35 INFO - ##### Finished read-buildbot-config step (success) 05:54:35 INFO - ##### 05:54:35 INFO - ##### 05:54:35 INFO - ##### Running download-and-extract step. 05:54:35 INFO - ##### 05:54:35 INFO - Running pre-action listener: _resource_record_pre_action 05:54:35 INFO - Running main action method: download_and_extract 05:54:35 INFO - mkdir: /builds/slave/test/build/tests 05:54:35 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')]} 05:54:35 INFO - https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:36 INFO - Downloaded 1361 bytes. 05:54:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:36 INFO - Using the following test package requirements: 05:54:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'jsshell-linux-x86_64.zip'], 05:54:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:36 INFO - https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:37 INFO - Downloaded 22701925 bytes. 05:54:37 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'] 05:54:37 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 05:54:38 INFO - Return code: 0 05:54:38 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 05:54: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')]} 05:54:38 INFO - https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:40 INFO - Downloaded 22701925 bytes. 05:54:40 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'] 05:54:40 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 05:54:42 INFO - Return code: 0 05:54:42 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')]} 05:54:42 INFO - https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:43 INFO - Downloaded 14405242 bytes. 05:54:43 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'] 05:54:43 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 05:54:43 INFO - Return code: 0 05:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:43 INFO - https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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 05:54:45 INFO - Downloaded 56449213 bytes. 05:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:45 INFO - mkdir: /builds/slave/test/properties 05:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:45 INFO - Contents: 05:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - Running post-action listener: set_extra_try_arguments 05:54:46 INFO - ##### 05:54:46 INFO - ##### Finished download-and-extract step (success) 05:54:46 INFO - ##### 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running populate-webroot step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: populate_webroot 05:54:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:46 INFO - '--tppagecycles', 05:54:46 INFO - '7'], 05:54:46 INFO - 'tests': ['tsvgm']}}, 05:54:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['damp', 'tps']}, 05:54:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['damp', 'tps']}, 05:54:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['dromaeo_dom']}, 05:54:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['basic_compositor_video']}, 05:54:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tsvgx', 05:54:46 INFO - 'tsvgr_opacity', 05:54:46 INFO - 'tart', 05:54:46 INFO - 'tscrollx', 05:54:46 INFO - 'cart']}, 05:54:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:46 INFO - 'tsvgr_opacity', 05:54:46 INFO - 'tart', 05:54:46 INFO - 'tscrollx', 05:54:46 INFO - 'cart']}, 05:54:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tp5o']}, 05:54:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['tp5o']}, 05:54:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s', 05:54:46 INFO - '--xperf_path', 05:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:46 INFO - 'tests': ['tp5n']}, 05:54:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--xperf_path', 05:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:46 INFO - 'tests': ['tp5n']}}, 05:54:46 INFO - 'talos.zip': {'path': '', 05:54:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - ##### 05:54:46 INFO - ##### Finished populate-webroot step (success) 05:54:46 INFO - ##### 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running create-virtualenv step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: create_virtualenv 05:54:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:46 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 05:54:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:46 INFO - Using real prefix '/usr' 05:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:48 INFO - Installing pip.................done. 05:54:48 INFO - Return code: 0 05:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:48 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')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:54:48 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 05:54:48 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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 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 05:54:49 INFO - Cleaning up... 05:54:49 INFO - Return code: 0 05:54:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:49 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')]} 05:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:49 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')]} 05:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:49 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:54:49 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 05:54:49 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 05:54:49 INFO - Using env: {'DISPLAY': ':0', 05:54:49 INFO - 'HOME': '/home/cltbld', 05:54:49 INFO - 'LANG': 'en_US.UTF-8', 05:54:49 INFO - 'LANGUAGE': 'en_US:en', 05:54:49 INFO - 'LOGNAME': 'cltbld', 05:54:49 INFO - 'MAIL': '/var/mail/cltbld', 05:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:49 INFO - 'MOZ_NO_REMOTE': '1', 05:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:49 INFO - 'NO_EM_RESTART': '1', 05:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:49 INFO - 'PWD': '/builds/slave/test', 05:54:49 INFO - 'SHELL': '/bin/bash', 05:54:49 INFO - 'SHLVL': '1', 05:54:49 INFO - 'TERM': 'linux', 05:54:49 INFO - 'TMOUT': '86400', 05:54:49 INFO - 'USER': 'cltbld', 05:54:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:49 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 INFO - Downloading/unpacking psutil>=3.1.1 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:51 INFO - Installing collected packages: psutil 05:54:51 INFO - Running setup.py install for psutil 05:54:51 INFO - building 'psutil._psutil_linux' extension 05:54:51 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 05:54:51 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 05:54:51 INFO - building 'psutil._psutil_posix' extension 05:54:51 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 05:54:51 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 05:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:51 INFO - Successfully installed psutil 05:54:51 INFO - Cleaning up... 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:51 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')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 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')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:54:51 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 05:54:51 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 05:54:51 INFO - Using env: {'DISPLAY': ':0', 05:54:51 INFO - 'HOME': '/home/cltbld', 05:54:51 INFO - 'LANG': 'en_US.UTF-8', 05:54:51 INFO - 'LANGUAGE': 'en_US:en', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MAIL': '/var/mail/cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SHLVL': '1', 05:54:51 INFO - 'TERM': 'linux', 05:54:51 INFO - 'TMOUT': '86400', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - '_': '/tools/buildbot/bin/python'} 05:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:52 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 05:54:52 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 05:54:52 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 05:54:52 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 05:54:52 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 05:54:52 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 05:54:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:53 INFO - Installing collected packages: mozsystemmonitor 05:54:53 INFO - Running setup.py install for mozsystemmonitor 05:54:54 INFO - Successfully installed mozsystemmonitor 05:54:54 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:54 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')]} 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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')]} 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:54:54 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 05:54:54 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 05:54:54 INFO - Using env: {'DISPLAY': ':0', 05:54:54 INFO - 'HOME': '/home/cltbld', 05:54:54 INFO - 'LANG': 'en_US.UTF-8', 05:54:54 INFO - 'LANGUAGE': 'en_US:en', 05:54:54 INFO - 'LOGNAME': 'cltbld', 05:54:54 INFO - 'MAIL': '/var/mail/cltbld', 05:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:54 INFO - 'MOZ_NO_REMOTE': '1', 05:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:54 INFO - 'NO_EM_RESTART': '1', 05:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:54 INFO - 'PWD': '/builds/slave/test', 05:54:54 INFO - 'SHELL': '/bin/bash', 05:54:54 INFO - 'SHLVL': '1', 05:54:54 INFO - 'TERM': 'linux', 05:54:54 INFO - 'TMOUT': '86400', 05:54:54 INFO - 'USER': 'cltbld', 05:54:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:54 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:56 INFO - warning: no files found matching '*.txt' 05:54:56 INFO - no previously-included directories found matching 'build' 05:54:56 INFO - no previously-included directories found matching 'dist' 05:54:56 INFO - no previously-included directories found matching '.git*' 05:54:56 INFO - Installing collected packages: jsonschema, functools32 05:54:56 INFO - Running setup.py install for functools32 05:54:56 INFO - warning: no files found matching '*.txt' 05:54:56 INFO - no previously-included directories found matching 'build' 05:54:56 INFO - no previously-included directories found matching 'dist' 05:54:56 INFO - no previously-included directories found matching '.git*' 05:54:56 INFO - Successfully installed jsonschema functools32 05:54:56 INFO - Cleaning up... 05:54:56 INFO - Return code: 0 05:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:56 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')]} 05:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:56 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')]} 05:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:56 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:54:56 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 05:54:56 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 05:54:56 INFO - Using env: {'DISPLAY': ':0', 05:54:56 INFO - 'HOME': '/home/cltbld', 05:54:56 INFO - 'LANG': 'en_US.UTF-8', 05:54:56 INFO - 'LANGUAGE': 'en_US:en', 05:54:56 INFO - 'LOGNAME': 'cltbld', 05:54:56 INFO - 'MAIL': '/var/mail/cltbld', 05:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:56 INFO - 'MOZ_NO_REMOTE': '1', 05:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:56 INFO - 'NO_EM_RESTART': '1', 05:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:56 INFO - 'PWD': '/builds/slave/test', 05:54:56 INFO - 'SHELL': '/bin/bash', 05:54:56 INFO - 'SHLVL': '1', 05:54:56 INFO - 'TERM': 'linux', 05:54:56 INFO - 'TMOUT': '86400', 05:54:56 INFO - 'USER': 'cltbld', 05:54:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:56 INFO - '_': '/tools/buildbot/bin/python'} 05:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 INFO - Downloading docopt-0.6.1.tar.gz 05:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:59 INFO - Running setup.py install for blobuploader 05:54:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:59 INFO - Running setup.py install for requests 05:54:59 INFO - Running setup.py install for docopt 05:55:00 INFO - Successfully installed blobuploader requests docopt 05:55:00 INFO - Cleaning up... 05:55:00 INFO - Return code: 0 05:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:55:00 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 05:55:00 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 05:55:00 INFO - Using env: {'DISPLAY': ':0', 05:55:00 INFO - 'HOME': '/home/cltbld', 05:55:00 INFO - 'LANG': 'en_US.UTF-8', 05:55:00 INFO - 'LANGUAGE': 'en_US:en', 05:55:00 INFO - 'LOGNAME': 'cltbld', 05:55:00 INFO - 'MAIL': '/var/mail/cltbld', 05:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:00 INFO - 'MOZ_NO_REMOTE': '1', 05:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:00 INFO - 'NO_EM_RESTART': '1', 05:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:00 INFO - 'PWD': '/builds/slave/test', 05:55:00 INFO - 'SHELL': '/bin/bash', 05:55:00 INFO - 'SHLVL': '1', 05:55:00 INFO - 'TERM': 'linux', 05:55:00 INFO - 'TMOUT': '86400', 05:55:00 INFO - 'USER': 'cltbld', 05:55:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:00 INFO - '_': '/tools/buildbot/bin/python'} 05:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 INFO - Running setup.py (path:/tmp/pip-ChD_Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 INFO - Running setup.py (path:/tmp/pip-w7pVNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:00 INFO - Running setup.py (path:/tmp/pip-vLrGU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:00 INFO - Running setup.py (path:/tmp/pip-azu2Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:00 INFO - Running setup.py (path:/tmp/pip-4cVw4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:00 INFO - Running setup.py (path:/tmp/pip-HX2Thk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:00 INFO - Running setup.py (path:/tmp/pip-1UVC4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:00 INFO - Running setup.py (path:/tmp/pip-C36ad0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:00 INFO - Running setup.py (path:/tmp/pip-owFhz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:00 INFO - Running setup.py (path:/tmp/pip-bXtMWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 INFO - Running setup.py (path:/tmp/pip-TUTxnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 INFO - Running setup.py (path:/tmp/pip-BaZNmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 INFO - Running setup.py (path:/tmp/pip-3Qw7on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Running setup.py (path:/tmp/pip-TTVayk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 INFO - Running setup.py (path:/tmp/pip-z7zPrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:01 INFO - Running setup.py (path:/tmp/pip-wJxE08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:01 INFO - Running setup.py (path:/tmp/pip-pKL0If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:01 INFO - Running setup.py install for manifestparser 05:55:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Running setup.py install for mozcrash 05:55:01 INFO - Running setup.py install for mozdebug 05:55:01 INFO - Running setup.py install for mozdevice 05:55:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Running setup.py install for mozfile 05:55:02 INFO - Running setup.py install for mozhttpd 05:55:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozinfo 05:55:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozInstall 05:55:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozleak 05:55:02 INFO - Running setup.py install for mozlog 05:55:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for moznetwork 05:55:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozprocess 05:55:02 INFO - Running setup.py install for mozprofile 05:55:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozrunner 05:55:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:03 INFO - Running setup.py install for mozscreenshot 05:55:03 INFO - Running setup.py install for moztest 05:55:03 INFO - Running setup.py install for mozversion 05:55:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:03 INFO - Cleaning up... 05:55:03 INFO - Return code: 0 05:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:03 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:55:03 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 05:55:03 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 05:55:03 INFO - Using env: {'DISPLAY': ':0', 05:55:03 INFO - 'HOME': '/home/cltbld', 05:55:03 INFO - 'LANG': 'en_US.UTF-8', 05:55:03 INFO - 'LANGUAGE': 'en_US:en', 05:55:03 INFO - 'LOGNAME': 'cltbld', 05:55:03 INFO - 'MAIL': '/var/mail/cltbld', 05:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:03 INFO - 'MOZ_NO_REMOTE': '1', 05:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:03 INFO - 'NO_EM_RESTART': '1', 05:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:03 INFO - 'PWD': '/builds/slave/test', 05:55:03 INFO - 'SHELL': '/bin/bash', 05:55:03 INFO - 'SHLVL': '1', 05:55:03 INFO - 'TERM': 'linux', 05:55:03 INFO - 'TMOUT': '86400', 05:55:03 INFO - 'USER': 'cltbld', 05:55:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:03 INFO - '_': '/tools/buildbot/bin/python'} 05:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:03 INFO - Running setup.py (path:/tmp/pip-pkO4AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:03 INFO - Running setup.py (path:/tmp/pip-C5LcCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:03 INFO - Running setup.py (path:/tmp/pip-ohlv94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:03 INFO - Running setup.py (path:/tmp/pip-jdnCbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:03 INFO - Running setup.py (path:/tmp/pip-y_sdEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:03 INFO - Running setup.py (path:/tmp/pip-NzdDUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:03 INFO - Running setup.py (path:/tmp/pip-w4YVJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:04 INFO - Running setup.py (path:/tmp/pip-sIlpbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:04 INFO - Running setup.py (path:/tmp/pip-khvVYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:04 INFO - Running setup.py (path:/tmp/pip-7aaU4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:04 INFO - Running setup.py (path:/tmp/pip-Xjo20U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:04 INFO - Running setup.py (path:/tmp/pip-CxqznG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:04 INFO - Running setup.py (path:/tmp/pip-5pZ2qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:04 INFO - Running setup.py (path:/tmp/pip-q9hFJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:04 INFO - Running setup.py (path:/tmp/pip-mxwSr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:04 INFO - Running setup.py (path:/tmp/pip-reKtR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:04 INFO - Running setup.py (path:/tmp/pip-N_UQWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:04 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 05:55:04 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 05:55:04 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 05:55:04 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 05:55:04 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 05:55:04 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 05:55:07 INFO - Downloading blessings-1.6.tar.gz 05:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:07 INFO - Installing collected packages: blessings 05:55:07 INFO - Running setup.py install for blessings 05:55:08 INFO - Successfully installed blessings 05:55:08 INFO - Cleaning up... 05:55:08 INFO - Return code: 0 05:55:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:09 INFO - Reading from file tmpfile_stdout 05:55:09 INFO - Current package versions: 05:55:09 INFO - argparse == 1.2.1 05:55:09 INFO - blessings == 1.6 05:55:09 INFO - blobuploader == 1.2.4 05:55:09 INFO - docopt == 0.6.1 05:55:09 INFO - functools32 == 3.2.3-2 05:55:09 INFO - jsonschema == 2.5.1 05:55:09 INFO - manifestparser == 1.1 05:55:09 INFO - mozInstall == 1.12 05:55:09 INFO - mozcrash == 0.17 05:55:09 INFO - mozdebug == 0.1 05:55:09 INFO - mozdevice == 0.48 05:55:09 INFO - mozfile == 1.2 05:55:09 INFO - mozhttpd == 0.7 05:55:09 INFO - mozinfo == 0.9 05:55:09 INFO - mozleak == 0.1 05:55:09 INFO - mozlog == 3.2 05:55:09 INFO - moznetwork == 0.27 05:55:09 INFO - mozprocess == 0.22 05:55:09 INFO - mozprofile == 0.28 05:55:09 INFO - mozrunner == 6.11 05:55:09 INFO - mozscreenshot == 0.1 05:55:09 INFO - mozsystemmonitor == 0.3 05:55:09 INFO - moztest == 0.7 05:55:09 INFO - mozversion == 1.4 05:55:09 INFO - psutil == 3.1.1 05:55:09 INFO - requests == 1.2.3 05:55:09 INFO - wsgiref == 0.1.2 05:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:09 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')]} 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 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')]} 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:55:09 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 05:55:09 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 05:55:09 INFO - Using env: {'DISPLAY': ':0', 05:55:09 INFO - 'HOME': '/home/cltbld', 05:55:09 INFO - 'LANG': 'en_US.UTF-8', 05:55:09 INFO - 'LANGUAGE': 'en_US:en', 05:55:09 INFO - 'LOGNAME': 'cltbld', 05:55:09 INFO - 'MAIL': '/var/mail/cltbld', 05:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:09 INFO - 'MOZ_NO_REMOTE': '1', 05:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:09 INFO - 'NO_EM_RESTART': '1', 05:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:09 INFO - 'PWD': '/builds/slave/test', 05:55:09 INFO - 'SHELL': '/bin/bash', 05:55:09 INFO - 'SHLVL': '1', 05:55:09 INFO - 'TERM': 'linux', 05:55:09 INFO - 'TMOUT': '86400', 05:55:09 INFO - 'USER': 'cltbld', 05:55:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:09 INFO - '_': '/tools/buildbot/bin/python'} 05:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 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)) 05:55:09 INFO - Cleaning up... 05:55:09 INFO - Return code: 0 05:55:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:09 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')]} 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 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')]} 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 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 0x1cf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, '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': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', '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 05:55:09 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 05:55:09 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 05:55:09 INFO - Using env: {'DISPLAY': ':0', 05:55:09 INFO - 'HOME': '/home/cltbld', 05:55:09 INFO - 'LANG': 'en_US.UTF-8', 05:55:09 INFO - 'LANGUAGE': 'en_US:en', 05:55:09 INFO - 'LOGNAME': 'cltbld', 05:55:09 INFO - 'MAIL': '/var/mail/cltbld', 05:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:09 INFO - 'MOZ_NO_REMOTE': '1', 05:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:09 INFO - 'NO_EM_RESTART': '1', 05:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:09 INFO - 'PWD': '/builds/slave/test', 05:55:09 INFO - 'SHELL': '/bin/bash', 05:55:09 INFO - 'SHLVL': '1', 05:55:09 INFO - 'TERM': 'linux', 05:55:09 INFO - 'TMOUT': '86400', 05:55:09 INFO - 'USER': 'cltbld', 05:55:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:09 INFO - '_': '/tools/buildbot/bin/python'} 05:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:09 INFO - Cleaning up... 05:55:09 INFO - Return code: 0 05:55:09 INFO - Running post-action listener: _resource_record_post_action 05:55:09 INFO - Running post-action listener: _start_resource_monitoring 05:55:09 INFO - Starting resource monitoring. 05:55:09 INFO - ##### 05:55:09 INFO - ##### Finished create-virtualenv step (success) 05:55:09 INFO - ##### 05:55:09 INFO - ##### 05:55:09 INFO - ##### Running install step. 05:55:09 INFO - ##### 05:55:09 INFO - Running pre-action listener: _resource_record_pre_action 05:55:09 INFO - Running main action method: install 05:55:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:09 INFO - Reading from file tmpfile_stdout 05:55:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:09 INFO - Reading from file tmpfile_stdout 05:55:09 INFO - Output received: 05:55:09 INFO - Usage: mozinstall [options] installer 05:55:09 INFO - Options: 05:55:09 INFO - -h, --help show this help message and exit 05:55:09 INFO - -d DEST, --destination=DEST 05:55:09 INFO - Directory to install application into. [default: 05:55:09 INFO - "/builds/slave/test"] 05:55:09 INFO - --app=APP Application being installed. [default: firefox] 05:55:09 INFO - mkdir: /builds/slave/test/build/application 05:55:09 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'] 05:55:09 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 05:55:30 INFO - Reading from file tmpfile_stdout 05:55:30 INFO - Output received: 05:55:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:30 INFO - Running post-action listener: _resource_record_post_action 05:55:30 INFO - ##### 05:55:30 INFO - ##### Finished install step (success) 05:55:30 INFO - ##### 05:55:30 INFO - ##### 05:55:30 INFO - ##### Running run-tests step. 05:55:30 INFO - ##### 05:55:30 INFO - Running pre-action listener: _resource_record_pre_action 05:55:30 INFO - Running main action method: run_tests 05:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:30 INFO - Python 2.7.3 05:55:30 INFO - Return code: 0 05:55:30 INFO - grabbing minidump binary from tooltool 05:55: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')]} 05:55:30 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 0x1fb03b0>, '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 0x1fb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:30 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 05:55:30 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 05:55:30 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 05:55:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:30 INFO - Return code: 0 05:55:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:30 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/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:55:30 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/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 05:55:30 INFO - Using env: {'DISPLAY': ':0', 05:55:30 INFO - 'HOME': '/home/cltbld', 05:55:30 INFO - 'LANG': 'en_US.UTF-8', 05:55:30 INFO - 'LANGUAGE': 'en_US:en', 05:55:30 INFO - 'LOGNAME': 'cltbld', 05:55:30 INFO - 'MAIL': '/var/mail/cltbld', 05:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:30 INFO - 'MOZ_NO_REMOTE': '1', 05:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:30 INFO - 'NO_EM_RESTART': '1', 05:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:30 INFO - 'PWD': '/builds/slave/test', 05:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:30 INFO - 'SHELL': '/bin/bash', 05:55:30 INFO - 'SHLVL': '1', 05:55:30 INFO - 'TERM': 'linux', 05:55:30 INFO - 'TMOUT': '86400', 05:55:30 INFO - 'USER': 'cltbld', 05:55:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016', 05:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:30 INFO - '_': '/tools/buildbot/bin/python'} 05:55:30 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/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:55:32 INFO - mozversion application_buildid: 20160630051527 05:55:32 INFO - mozversion application_changeset: 7940be96e124a4f6b812d2b3ad6762f2921be04b 05:55:32 INFO - mozversion application_display_name: Nightly 05:55:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:32 INFO - mozversion application_name: Firefox 05:55:32 INFO - mozversion application_remotingname: firefox 05:55:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:55:32 INFO - mozversion application_vendor: Mozilla 05:55:32 INFO - mozversion application_version: 50.0a1 05:55:32 INFO - mozversion platform_buildid: 20160630051527 05:55:32 INFO - mozversion platform_changeset: 7940be96e124a4f6b812d2b3ad6762f2921be04b 05:55:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:55:32 INFO - mozversion platform_version: 50.0a1 05:55:32 INFO - using testdate: 1467291332 05:55:32 INFO - actual date: 1467291332 05:55:32 INFO - starting webserver on 'localhost:39245' 05:55:32 INFO - SUITE-START | Running 2 tests 05:55:32 INFO - TEST-START | dromaeo_css 05:55:32 INFO - operating with platform_type : linux_ 05:55:32 INFO - Initialising browser for dromaeo_css test... 05:55:32 INFO - TEST-INFO | started process 20679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJNkKd/profile http://localhost:39245/getInfo.html) 05:55:41 INFO - PROCESS | 20679 | __metrics Screen width/height:1600/1200 05:55:41 INFO - PROCESS | 20679 | colorDepth:24 05:55:41 INFO - PROCESS | 20679 | Browser inner width/height: 1024/697 05:55:41 INFO - PROCESS | 20679 | __metrics 05:55:43 INFO - PROCESS | 20679 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:43 INFO - PROCESS | 20679 | console.error: PushService: 05:55:43 INFO - PROCESS | 20679 | stateChangeProcessEnqueue: Error transitioning state 05:55:43 INFO - PROCESS | 20679 | UnknownError 05:55:44 INFO - TEST-INFO | 20679: exit 0 05:55:44 INFO - Browser initialized. 05:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:44 INFO - TEST-INFO | started process 20764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJNkKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:56 INFO - PROCESS | 20764 | RSS: Main: 159039488 05:55:56 INFO - PROCESS | 20764 | 05:56:48 INFO - PROCESS | 20764 | 1467291408019 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] 05:59:00 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39245/tests/dromaeo/cssquery-ext.html) 05:59:01 INFO - PROCESS | 20764 | RSS: Main: 268333056 05:59:01 INFO - PROCESS | 20764 | 06:02:04 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-ext.html (next: http://localhost:39245/tests/dromaeo/cssquery-jquery.html) 06:02:05 INFO - PROCESS | 20764 | RSS: Main: 249696256 06:02:05 INFO - PROCESS | 20764 | 06:05:07 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39245/tests/dromaeo/cssquery-mootools.html) 06:05:08 INFO - PROCESS | 20764 | RSS: Main: 245104640 06:05:08 INFO - PROCESS | 20764 | 06:08:10 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39245/tests/dromaeo/cssquery-prototype.html) 06:08:10 INFO - PROCESS | 20764 | RSS: Main: 239054848 06:08:10 INFO - PROCESS | 20764 | 06:11:14 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39245/tests/dromaeo/cssquery-yui.html) 06:11:14 INFO - PROCESS | 20764 | RSS: Main: 231268352 06:11:14 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | Cycle 1(1): loaded http://localhost:39245/tests/dromaeo/cssquery-yui.html (next: http://localhost:39245/tests/dromaeo/cssquery-dojo.html) 06:14:17 INFO - PROCESS | 20764 | RSS: Main: 280162304 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | __start_tp_report 06:14:17 INFO - PROCESS | 20764 | _x_x_mozilla_page_load 06:14:17 INFO - PROCESS | 20764 | _x_x_mozilla_page_load_details 06:14:17 INFO - PROCESS | 20764 | |i|pagename|runs| 06:14:17 INFO - PROCESS | 20764 | |0;dojo.html;2565.538203123437;2567.1785028790787;2601.154624746958;2620.554505734025;2627.579587266038;4558.065596552707;4654.3018547217935;4671.065786842628;4751.097291514614;4789.521047895213;4709.4348678158585;4711.835085771999;4740.834070807522;4754.215554433515;4769.594584460325;4144.191882582898;4291.785410729459;4380.189664911985;4400.691951563392;4495.887602809939;4415.712978656377;4443.977780111095;4457.59881610655;4468.50846406895;4494.528074552174;4228.302330115543;4278.101598664284;4304.526502084768;4362.672799540015;4366.170427618742;4277.786110694484;4298.484181898161;4308.3537469379535;4339.370791235253;4357.934630980538;4329.415528903621;4334.306510958231;4344.9348259776125;4386.407834942273;4387.714798538085;4646.930296045562;4663.743494107823;4703.15343238217;4730.645201609893;4773.832915847928;5049.368828896388;5093.1087059764395;5104.566111880495;5104.923426148611;5119.25770763241;5135.024345374367;5138.409082955471;5143.819966301199;5149.356330458692;5158.819441319573;4644.907101857978;4714.269288260325;4746.335513028179;4756.096341695067;4841.15279826029;5253.422123566481;5282.075636763628;5283.709395983258;5296.020236256305;5299.2845965794895;4926.33494478248;5007.524285192901;5060.544550990428;5061.266116413173;5062.164742817394;5030.723310217973;5063.3923929128005;5067.037262920034;5069.44236134025;5085.898282034413;5018.89962200754;5021.548060674557;5031.874203144951;5041.899162016739;5075.492450754895;4884.731339776346;4930.605551555938;5006.274090256892;5018.673786203885;5020.748962551857;4341.15347507233;4361.978190109029;4364.716293440916;4383.890402739957;4411.867643970686;3769.6795772359656;3774.1885494618787;3793.241351729665;3819.732618716663;3822.3119838429348;4365.934510982338;4389.824407023683;4391.341298805205;4420.690551661352;4437.400950871655;4969.602431805447;5023.673461225082;5030.647854650212;5074.238864170404;5079.923801142986;4319.438472998553;4335.436393268855;4337.522872484024;4339.522652508222;4390.517043125254;4571.725696458157;4575.450945886515;4575.565321294472;4583.404157459576;4624.329472226508;4668.673192876466;4684.882877927943;4743.620510359232;4775.2598347256235;4786.1624215762795;5094.821681241138;5112.948870511247;5121.1550094234035;5124.154514505214;5170.069387510284;4789.640776941674;4792.185328494094;4798.424189097331;4799.904001920012;4855.36880205571;4941.332920055746;4953.2074868020945;4998.550130488128;5020.468757029141;5035.219540971156;5111.693298402108;5115.335006449138;5119.334486516729;5120.359955005624;5166.173412254021;4810.158222311152;4955.702657840397;4959.454460009469;4961;4963.429205641253;4878.56092951636;4916.06594746997;4917.606591472745;4924.4090709115135;4940.9505904941925;4843.685160464559;4844.103840789465;4879.634027447884;4908.680935739166;4959.231319145538;4815.30178124177;4939.185034469272;5067.417247016493;5071.543561079373;5104.132297509358;4925.704457732548;4926.088673595396;4958.727270000185;4963.776630051729;4992.975035124801 06:14:17 INFO - PROCESS | 20764 | |1;ext.html;574.2993547871597;584.4652143288889;584.7281014328337;587.9000569903113;594.5570549940295;27450.313742156457;42625.57374426255;44146.99999999992;44173.558264417385;44266.33600495995;40049.59950400495;40366.798166009205;40389.79805100978;40404;40474;7389.482736208468;7879.093904201004;8015.7194498192575;8017.198280171994;8019.318357939582;10052.246081543914;10310.793784124313;10318.638847640334;10635.627753028646;10660.573577056908;10133.797324053514;10149.492525373738;10150.0864922157;10181.083702466776;10254.948725256401;7457.925420745777;9899.109080182781;9941.254405919513;10158.28891977562;10429.68710938673;10174.287799854013;10242.846357304647;10267.486625668687;10271.126954208901;10280.228982826318;38005.809970949966;38306;38361.42457863134;38388.23223535542;38473.42289865654;3242;3387.728981681484;3477.009052420048;3500.982495087508;3806.9619303807162;29623.851880740458;29666.85166574175;29687.25781855471;29759.851200744073;29943;3220.7584431167757;3253.33306672134;3274.67253274673;3307.8676852926096;3358.6809253120914;242883;243584;243654;244337;245115;31483.37033259322;51155;51367.74316128396;51649.225261621104;51679.48320516822;32984.34031319408;33131;33521.66478335185;33529.66470335265;33583.664163358546;11786.941065294619;11876.703082422835;11889.108316876269;11975.700607484883;12054.939725301318;8760.386772925835;10379.481025948824;10532.631357902437;10818.891811081945;10829.133669306437;7854.528728276207;7896.565688887166;7939.761807145795;7971.60141992898;7991.120976692559;3096.7212950834532;3110.377924415081;3133.310671652233;3165.920851978719;3195.2810617611317;850.3027517435644;941.6562954521687;976.3117002513211;977.193815102529;984.3011461862015;27668.446631067265;28352.149435516967;28667.426651466852;28817.56773648397;28996.27509312284;954.7660823098386;958.6596758150896;1004.7387679203314;1014.1531820929459;1041.9895801042044;14550.854491455162;15420.537383878502;15443.459478918185;15864.762028569581;16129.83870161307;406471;407511;408557;409599;409785;49033.264501032514;50041.24938125931;50123.74938125286;50125.74937125291;50186.74906625444;1063;1128.7008942630046;1174.3247632611112;1200.2378489658954;1217.945192466341;26756.331091722863;28542;29221.41557168887;29260.122196334145;29539.556906645987;40688.186236274516;41120.79439602783;41346.379804302356;41445;41448.3782743253;316014;319708.2335531444;320572;320796.9601519961;321457;21912.342629721134;22259.77740222577;22370;22977.310680679606;24315.39211519726;40611.1877762449;41028.589714102476;42489;43498;44004.55995440004;35794.64205357913;36460.81769591241;36628;36695.26609467849;36813;36308.455373168894;36406.81796591;36936.59912105704;36949;37147;33797.32405351928;34531.654683453846;34776.82611586926;35070;35124.473132902516;32524.51213231851;32846.34307313888;33102;33137.17157070996;33482.66517334795;24954.750452495242;25175.37061573475;25325.240242792745;25371.873140634918;25823 06:14:17 INFO - PROCESS | 20764 | |2;jquery.html;345.7191106948755;373.1380511019545;376.52745804015944;379.79680870734165;394.50095629029283;12970.80543791844;14580.708385832277;17176;17186.398476053342;17199.054052027135;15526.611834704137;15549.455769048085;15774.921125394385;16226.10756408397;16712.2479488423;4902.803887844482;5087.720175390352;5105.285260063594;5141.228815677641;5142.202958541432;3726.5341832270965;5013.874653133683;5672.744726487318;5950.55370847186;5994.190784244137;5979.581429299951;5990.2212712347555;6001.819945401645;6014.819555413323;6023.36754640763;5743.569232307573;5968.403159684019;5988.580799344048;5989.580729348947;5992.981193197167;3364.3775901458307;4957.7769000395065;5261.815836445744;5269.420363759983;5272.868178295574;20852.687209691867;20928;21168.153273869026;21178.576428471497;21501.892490537604;1989.711491833676;2047.3653167518116;2158.287765037534;2262.151693115082;2526.5325914705836;6387.489000879965;6408.487321014354;6413.422791948747;11763.7059073523;13105.33365866774;1679.9160041997852;1705.8294170582967;1758.674645190631;1847.2795609712223;1875.6061227142316;55404.32505895989;56383.71808140933;57158.42841571572;66379.3362066378;69957;9371.390859594105;10245.590176392861;10272.691819245434;10461.529231184615;10472.319299245524;14018.789718154236;14123.152610843383;14131.505397311044;14149.434022639185;14156.433742650384;7067.89398159028;7211.603361815046;7393.149787774367;7440.10718713747;7457.813554661068;7019.508634395544;7054.08296921397;7062.505624606331;7134.785956421316;7137.964310178416;4440.977795111004;4450.5549445055885;4485.080558485568;4494.617957473652;4571.794269257892;1791.5610675384614;1811.5923917118544;1818.3363072478714;1823.881447705895;1876.1088482970479;829.4567058576642;859.9895123230305;872.6553011560399;921.1433366968784;926.4626516620344;16446.177691115397;17293.308267669152;17629.647407052045;17643.647127057386;17804.732929006077;837.2506606587192;860.9225169734754;871.5467956662627;871.7210492642421;884.5842454046588;9456.763580910394;9753.756156096013;9754;9832.852507212398;9904.653337133166;423198;425322;427906;431308;438975;76672;77101.6144919283;77914.6104269475;79655.60172199101;80090.84403450918;781.6990458673451;843.6541018182515;892.8437523433373;893.3567831161554;908.2688435809237;15406.537803865454;16019.919900400424;16073.347897596766;16118;16405.83594164043;35853.82073089618;36925;37933.81033094927;40596.18807623772;41219.1756164881;51315.743421282656;54975;55620.721896390256;56101.719491402284;56195.43804561902;7477.738279160203;7763.10724266694;7789.437126342731;7821.256980586835;8108.189181081844;8414.83170336602;11188.328700278009;11199.776004480027;11227.494762735532;11941.283522988648;10101.747456313651;10161.237907156845;10161.644342447978;10297.17622590206;10478.056974871994;10422.322549034288;10526.263161578616;10693.144548436261;10763.623273185402;10800.351978881292;10352.275340726379;10578.312409693654;10737;10753.946230268799;10845.295055821347;7903.446758726834;8038.075621303625;8038.39712021589;8053.154418786177;8158.021037475541;9110.316726245426;10072.395656260647;10396;10686.679399618024;10808.18938579594 06:14:17 INFO - PROCESS | 20764 | |3;mootools.html;1383.3152589468211;1425.06658138919;1505.2398538737937;1688.333108422174;1740.7736994190752;7625.885611715822;8052.51684898905;8105.432619716622;8108;8118.2693557579805;6938.965305173467;7494.325510704036;7733.883991740115;7744.341730952861;7955.284024437799;2148.205164089289;2208.8232941364654;2210.0386331945574;2213.50196205854;2215.3907675389314;2162.4485756132162;2171.326888664519;2192.550527141932;2196.934091977243;2197.7252843394576;1910.42687193842;2167.295628920599;2213.1700612270397;2220.7785717855195;2224.4883676754357;2187.387531491185;2187.671849222613;2209.834262430324;2210.403191138392;2232.598132336179;2182.8035476807163;2189.200941656284;2190.496185877257;2191.1783081344497;2193.5393567350875;7810.726624568169;7861.528308301463;7864.174261702496;7875.566843823587;7879.724209652634;4330.978345108286;4456.331550267453;4500.144972455223;4560.931586026212;4565.406497155382;2772.916812495608;2814.8311101333984;2888.725571070766;2910.738033576988;2914.417116576693;937.9108984646448;943.7593413679537;954.9379290346175;957.2676902169845;963.657901444984;9832.213422926148;9849.458279794608;9862.852057219076;9863.60545578176;9965.501724913798;3945.8027098645525;4006.6193711597352;4165.271077561475;4168.854090106832;4175.248455278079;8480.703175388831;8526.914730852735;8532.018817835904;8537;8545.401821872534;4274.316109422478;4325.6106950374615;4337.262665346899;4337.50118736343;4341.522432532419;3925.9214815703526;3927.666148377363;3933.233019561158;3944.3097457944746;3944.546377166605;3540.362734707726;3580.695640870555;3582.4089025311055;3627.7460577759302;3643.5809881863397;1052.884182739898;1126.245415571569;1146.896779289868;1162.0587324267372;1163.0463020323255;751.8084782858017;782.4757412533617;798.7124635131348;832.5213002523573;863.9740807775777;5229.346331708536;5281.0758117329315;5375.462453754593;5404.216388623706;5414.3232095988005;879.8284334554701;904.5884122724144;914.8581969794692;933.7665583604099;943.9197668198143;3450.689437950546;3591.982040089783;3595.406757884972;3618.7466877318334;3634.909127271839;9654.71035868911;9774.071463210983;9821.705348839547;9935.254855885838;9985.650502232533;8459.957700211582;9142.725718228463;9611.807763844685;9871.851922221173;9873.111419972238;7010.404115650125;7283.672234749449;7289.416846652255;7361;7415.998840156618;5282.577393808563;5353.464653534771;5451.20957461158;5490.5607551395;5534.169874518854;8749.606267717842;8930.240929521064;8956.776080598038;9058.275337972815;9111.908880911371;9060.592273347584;9098.454092754457;9101.590428430869;9224.677136300197;9338.439693618404;6929.307069293232;7054.08296921397;7089.82275443118;7113.181984071898;7121;7315.963420182865;7562.432817538816;7572.432067594842;7618.314351708373;7685.077790664933;7037.26108758573;7083.362497375261;7154.642267886481;7179.066721326194;7194.0647715798705;6872.553284036521;6929.133858267716;7023.824404389931;7038.612876291853;7052.294770522906;6200.782972595937;6237.656928868956;6280.591761535486;6292.465140463112;6294.370562943669;4265.232258193555;4340.110277393063;4381.430414046154;4424.7123936944;4466.263066593976;4328.696991210585;4330.285502891988;4456.331550267486;4502.707324023928;4506.301523263899 06:14:17 INFO - PROCESS | 20764 | |4;prototype.html;295.60241475215827;300.62421972534327;302.57639304973037;302.7698948798913;306.47286666932865;4828.493008234138;4875.683565437339;4888.926666100003;4889.144399730047;4937.925931111027;4799.1841386964215;4817.6145908327335;4837.782299796509;4842.249451335048;4851;3613.5121758562586;3736.5889752127246;3748.625137486243;3751.756135851161;3759.0978165240417;3662.249238906031;3747.4566187902738;3829.3681542545587;3833.463315135883;3860.4981352424147;3768.3970564709653;3776.188119554295;3782.6217378262227;3813.504244448218;3817.2747178036225;3526.2418580005165;3715.256948610289;3777.7922214278206;3778.1688028633657;3785.261873934584;3197.536357228212;3198.200449887528;3229.450993331139;3233.983830080858;3236.223306406469;4688.507706690816;4693;4697.201475749131;4707.741074240916;4766.594839438651;4097.44684467596;4217.367394890791;4263.893402664927;4267.91464170718;4287.164003019412;5010.722265822228;5016.774245158977;5027.698338099725;5048.671836330664;5062.291279220912;3581.2658405026905;3588.1926566522584;3608.4046132388125;3611.56661200655;3622.492851000862;5182.32629758129;5242.423333433358;5244.2956039287;5305.469453054702;5342.626016178869;3574.749767516301;3615.728820338485;3624.0758606555687;3629.074585980558;3651.342758303531;3639.3994990826745;3669.5596528416227;3676.963230367662;3680.0983758979223;3692.9446058309145;4225.859018065105;4229.830806767694;4234;4251.873253587802;4261.4673165854265;4977.452480227172;5068;5068.670536415121;5074.49255074497;5102.770375333044;1267.7401132767761;1277.2591896699892;1278.4630455208835;1282.2755143343982;1283.3508941010757;797.4696826610356;815.8368326334638;821.1952286759009;823.3413269384469;827.6937533112787;4358.891027724332;4410.2282100632265;4458.977705111519;4471.977640111843;4500.887477813081;5196.714180720097;5200.427952925251;5200.6879587224885;5200.76596553156;5201.765920533585;4444.911101777946;4456.487503937024;4465.732056076646;4467.821287148543;4471.910561788746;2592.546304396723;2784.4013537089622;2799.846008469513;2801.131649188758;2801.7898657600763;4929.802807887644;4946.975265123651;4949.727764972961;4951.306817045616;4963.181075122564;5232.92150617741;5318.760655770422;5368.221607866837;5387.9461205388225;5395.81114660985;4861.562459378673;4864.562189402829;4889.755512224446;4919.925046845721;4951.183054795918;5189.221616757365;5226.581873450039;5227.71920879387;5239.659422137549;5244.868878278074;4891.584215341736;5124.461931497139;5146.426786606697;5147.433782283871;5171.663841850268;4915.0415668944215;4919.139150648693;4924.8276310328965;4925.926111108264;4934.161192597196;3692.6861216796874;3713.1088538751046;3727.571329297057;3741.28915506053;3744.3260213161893;5013.006612521981;5240.868978275574;5250.606204534599;5253.529011876681;5262.921056184084;5076.593872490266;5083.694978301313;5098.617603679813;5099.643024988215;5101.642884998163;5069.290299358019;5079.796808127781;5081.263216833612;5090;5090.185570308733;4666.673332866802;4944.159492886146;4951.801927922843;4956.900861982668;4966.826161084345;4850.83022094225;5006.49935006511;5008.774605142705;5015.548600625962;5084.466131056186;4882.853514394574;4901.142300097397;4910.582600479;5028.44118323321;5031.144705400164 06:14:17 INFO - PROCESS | 20764 | |5;yui.html;605.0172648841212;660.9074729537863;668.5954997226675;680.707295862779;683.7367613468813;12523.373831308432;13579.728405431886;13623.79564306535;13627.931860340697;13632.522861699843;12482.625521234377;12483.937580312086;12657.873421265784;12690;12904.548340808074;634.1027446163696;756.2059837170976;765.3456294867891;786.5595266650665;786.7207141464755;772.038811679457;784.1844481739013;786.830831371255;787.0044393841795;787.4920676163871;803.052398170159;803.5500119932827;804.6861723927673;804.7907544038563;805.0500409516768;657.6481582353442;669.3707914560298;669.3741351836048;676.4182802789597;795.5067857928063;581.0557843504306;601.1523751510393;603.2067830802481;603.432773193197;604.4741075264548;11131.610393636183;11136.498857551429;11312.151588630803;11348.716282093013;11369.090472762242;12038.518459261619;12649.747005059939;13410.530631427853;13468.663283417993;13521.526746563823;11258.774824503545;11386.202965792398;11593.478293476814;11661.242019268806;11781.293122412682;4289.613934745857;4303.33298338758;4367.737935723867;4400.669949753749;4464.285714285731;58595.41404585942;58886.70556647232;58925.41074589285;58975.705121474544;59059.40940590582;10418.739531511774;10709.357438553712;11050.502727377287;11203.383813890152;11232.10143188543;19387.4183774487;19488.70766938497;19501.317453889045;19507.219711211677;19509.414717558495;6415.101885736;6447;6586.341365863375;6760.560563563353;6796.558223715541;3677.42999835026;3677.595464498903;3685.6867166291167;3720.5535335759882;3865.768053916774;2859.1994241612383;2959.334149816274;2963;2969.302213979713;2972.866221020016;515.1242887091959;537.9435159308294;570.4523657288966;572.802383177803;579.0532479396218;500.20966872341614;553.9113741801373;555.2920026965651;568.0967262053355;577.8584246859547;7827.491213071132;7942.801429964182;8135.79660508492;8228.259456648811;8272.958635206905;523.5628250410873;547.3295213363677;555.9555235581144;565.9066254068115;573.1689050876246;3966.861159859391;4071.7353372030725;4094.201630682048;4111.578675102748;4151.896202594899;98169.50915245379;105676;105780.47109764555;108010.45994769975;109525.45237273762;91787;93476;93581.5320923391;93767.59348609776;94223;42677.14645707068;69569;73455;75372;78273.60863195648;7608.505447146139;7686.500377475446;7706.422018348759;7764;7778.105517865518;47624;47788.761056195886;48101.278480823516;48337;49369.753151234014;62872.68563657152;65617;70455.64772176312;72268;72563.27436725565;10638.787224255626;10688;10943.781124377627;11012.339259644446;11064.834027489433;11558.653240402802;11767.705807354885;11898.583549575724;12005.579804707142;12555.43500542496;10274.280800343904;10711.303765255234;10800.405977671304;10809.35143891369;10899.455027248447;10086.8486972694;10874.23880328401;10919.290246133976;11190.32858028521;11219.495122719334;10064.949675251577;10159.593616255266;10563.049325560736;10884.619038333936;10940.1794865387;8366.163383661586;8432.789180270542;8526.488410695378;8601;8743.912560874563;7940.6426710796995;8334.749957501284;9187.265018798615;9194.540272986458;9195.632174713204 06:14:17 INFO - PROCESS | 20764 | __end_tp_report 06:14:17 INFO - PROCESS | 20764 | __start_cc_report 06:14:17 INFO - PROCESS | 20764 | _x_x_mozilla_cycle_collect,1073 06:14:17 INFO - PROCESS | 20764 | __end_cc_report 06:14:17 INFO - PROCESS | 20764 | __startTimestamp1467292457828__endTimestamp 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | ------- Summary: start ------- 06:14:17 INFO - PROCESS | 20764 | Number of tests: 6 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#0] dojo.html Cycles:165 Average:4692.80 Median:4799.90 stddev:500.97 (10.4%) stddev-sans-first:473.90 06:14:17 INFO - PROCESS | 20764 | Values: 2565.5 2567.2 2601.2 2620.6 2627.6 4558.1 4654.3 4671.1 4751.1 4789.5 4709.4 4711.8 4740.8 4754.2 4769.6 4144.2 4291.8 4380.2 4400.7 4495.9 4415.7 4444.0 4457.6 4468.5 4494.5 4228.3 4278.1 4304.5 4362.7 4366.2 4277.8 4298.5 4308.4 4339.4 4357.9 4329.4 4334.3 4344.9 4386.4 4387.7 4646.9 4663.7 4703.2 4730.6 4773.8 5049.4 5093.1 5104.6 5104.9 5119.3 5135.0 5138.4 5143.8 5149.4 5158.8 4644.9 4714.3 4746.3 4756.1 4841.2 5253.4 5282.1 5283.7 5296.0 5299.3 4926.3 5007.5 5060.5 5061.3 5062.2 5030.7 5063.4 5067.0 5069.4 5085.9 5018.9 5021.5 5031.9 5041.9 5075.5 4884.7 4930.6 5006.3 5018.7 5020.7 4341.2 4362.0 4364.7 4383.9 4411.9 3769.7 3774.2 3793.2 3819.7 3822.3 4365.9 4389.8 4391.3 4420.7 4437.4 4969.6 5023.7 5030.6 5074.2 5079.9 4319.4 4335.4 4337.5 4339.5 4390.5 4571.7 4575.5 4575.6 4583.4 4624.3 4668.7 4684.9 4743.6 4775.3 4786.2 5094.8 5112.9 5121.2 5124.2 5170.1 4789.6 4792.2 4798.4 4799.9 4855.4 4941.3 4953.2 4998.6 5020.5 5035.2 5111.7 5115.3 5119.3 5120.4 5166.2 4810.2 4955.7 4959.5 4961.0 4963.4 4878.6 4916.1 4917.6 4924.4 4941.0 4843.7 4844.1 4879.6 4908.7 4959.2 4815.3 4939.2 5067.4 5071.5 5104.1 4925.7 4926.1 4958.7 4963.8 4993.0 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#1] ext.html Cycles:180 Average:46910.69 Median:33134.09 stddev:87353.13 (263.6%) stddev-sans-first:87528.89 06:14:17 INFO - PROCESS | 20764 | Values: 574.3 584.5 584.7 587.9 594.6 27450.3 42625.6 44147.0 44173.6 44266.3 40049.6 40366.8 40389.8 40404.0 40474.0 7389.5 7879.1 8015.7 8017.2 8019.3 10052.2 10310.8 10318.6 10635.6 10660.6 10133.8 10149.5 10150.1 10181.1 10254.9 7457.9 9899.1 9941.3 10158.3 10429.7 10174.3 10242.8 10267.5 10271.1 10280.2 38005.8 38306.0 38361.4 38388.2 38473.4 3242.0 3387.7 3477.0 3501.0 3807.0 29623.9 29666.9 29687.3 29759.9 29943.0 3220.8 3253.3 3274.7 3307.9 3358.7 242883.0 243584.0 243654.0 244337.0 245115.0 31483.4 51155.0 51367.7 51649.2 51679.5 32984.3 33131.0 33521.7 33529.7 33583.7 11786.9 11876.7 11889.1 11975.7 12054.9 8760.4 10379.5 10532.6 10818.9 10829.1 7854.5 7896.6 7939.8 7971.6 7991.1 3096.7 3110.4 3133.3 3165.9 3195.3 850.3 941.7 976.3 977.2 984.3 27668.4 28352.1 28667.4 28817.6 28996.3 954.8 958.7 1004.7 1014.2 1042.0 14550.9 15420.5 15443.5 15864.8 16129.8 406471.0 407511.0 408557.0 409599.0 409785.0 49033.3 50041.2 50123.7 50125.7 50186.7 1063.0 1128.7 1174.3 1200.2 1217.9 26756.3 28542.0 29221.4 29260.1 29539.6 40688.2 41120.8 41346.4 41445.0 41448.4 316014.0 319708.2 320572.0 320797.0 321457.0 21912.3 22259.8 22370.0 22977.3 24315.4 40611.2 41028.6 42489.0 43498.0 44004.6 35794.6 36460.8 36628.0 36695.3 36813.0 36308.5 36406.8 36936.6 36949.0 37147.0 33797.3 34531.7 34776.8 35070.0 35124.5 32524.5 32846.3 33102.0 33137.2 33482.7 24954.8 25175.4 25325.2 25371.9 25823.0 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#2] jquery.html Cycles:180 Average:25397.03 Median:221707.99 stddev:70611.85 (31.8%) stddev-sans-first:70784.88 06:14:17 INFO - PROCESS | 20764 | Values: 345.7 373.1 376.5 379.8 394.5 12970.8 14580.7 17176.0 17186.4 17199.1 15526.6 15549.5 15774.9 16226.1 16712.2 4902.8 5087.7 5105.3 5141.2 5142.2 3726.5 5013.9 5672.7 5950.6 5994.2 5979.6 5990.2 6001.8 6014.8 6023.4 5743.6 5968.4 5988.6 5989.6 5993.0 3364.4 4957.8 5261.8 5269.4 5272.9 20852.7 20928.0 21168.2 21178.6 21501.9 1989.7 2047.4 2158.3 2262.2 2526.5 6387.5 6408.5 6413.4 11763.7 13105.3 1679.9 1705.8 1758.7 1847.3 1875.6 55404.3 56383.7 57158.4 66379.3 69957.0 9371.4 10245.6 10272.7 10461.5 10472.3 14018.8 14123.2 14131.5 14149.4 14156.4 7067.9 7211.6 7393.1 7440.1 7457.8 7019.5 7054.1 7062.5 7134.8 7138.0 4441.0 4450.6 4485.1 4494.6 4571.8 1791.6 1811.6 1818.3 1823.9 1876.1 829.5 860.0 872.7 921.1 926.5 16446.2 17293.3 17629.6 17643.6 17804.7 837.3 860.9 871.5 871.7 884.6 9456.8 9753.8 9754.0 9832.9 9904.7 423198.0 425322.0 427906.0 431308.0 438975.0 76672.0 77101.6 77914.6 79655.6 80090.8 781.7 843.7 892.8 893.4 908.3 15406.5 16019.9 16073.3 16118.0 16405.8 35853.8 36925.0 37933.8 40596.2 41219.2 51315.7 54975.0 55620.7 56101.7 56195.4 7477.7 7763.1 7789.4 7821.3 8108.2 8414.8 11188.3 11199.8 11227.5 11941.3 10101.7 10161.2 10161.6 10297.2 10478.1 10422.3 10526.3 10693.1 10763.6 10800.4 10352.3 10578.3 10737.0 10753.9 10845.3 7903.4 8038.1 8038.4 8053.2 8158.0 9110.3 10072.4 10396.0 10686.7 10808.2 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#3] mootools.html Cycles:180 Average:5115.33 Median:6219.22 stddev:2852.32 (45.9%) stddev-sans-first:2846.53 06:14:17 INFO - PROCESS | 20764 | Values: 1383.3 1425.1 1505.2 1688.3 1740.8 7625.9 8052.5 8105.4 8108.0 8118.3 6939.0 7494.3 7733.9 7744.3 7955.3 2148.2 2208.8 2210.0 2213.5 2215.4 2162.4 2171.3 2192.6 2196.9 2197.7 1910.4 2167.3 2213.2 2220.8 2224.5 2187.4 2187.7 2209.8 2210.4 2232.6 2182.8 2189.2 2190.5 2191.2 2193.5 7810.7 7861.5 7864.2 7875.6 7879.7 4331.0 4456.3 4500.1 4560.9 4565.4 2772.9 2814.8 2888.7 2910.7 2914.4 937.9 943.8 954.9 957.3 963.7 9832.2 9849.5 9862.9 9863.6 9965.5 3945.8 4006.6 4165.3 4168.9 4175.2 8480.7 8526.9 8532.0 8537.0 8545.4 4274.3 4325.6 4337.3 4337.5 4341.5 3925.9 3927.7 3933.2 3944.3 3944.5 3540.4 3580.7 3582.4 3627.7 3643.6 1052.9 1126.2 1146.9 1162.1 1163.0 751.8 782.5 798.7 832.5 864.0 5229.3 5281.1 5375.5 5404.2 5414.3 879.8 904.6 914.9 933.8 943.9 3450.7 3592.0 3595.4 3618.7 3634.9 9654.7 9774.1 9821.7 9935.3 9985.7 8460.0 9142.7 9611.8 9871.9 9873.1 7010.4 7283.7 7289.4 7361.0 7416.0 5282.6 5353.5 5451.2 5490.6 5534.2 8749.6 8930.2 8956.8 9058.3 9111.9 9060.6 9098.5 9101.6 9224.7 9338.4 6929.3 7054.1 7089.8 7113.2 7121.0 7316.0 7562.4 7572.4 7618.3 7685.1 7037.3 7083.4 7154.6 7179.1 7194.1 6872.6 6929.1 7023.8 7038.6 7052.3 6200.8 6237.7 6280.6 6292.5 6294.4 4265.2 4340.1 4381.4 4424.7 4466.3 4328.7 4330.3 4456.3 4502.7 4506.3 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#4] prototype.html Cycles:180 Average:4194.59 Median:4846.54 stddev:1229.55 (25.4%) stddev-sans-first:1197.66 06:14:17 INFO - PROCESS | 20764 | Values: 295.6 300.6 302.6 302.8 306.5 4828.5 4875.7 4888.9 4889.1 4937.9 4799.2 4817.6 4837.8 4842.2 4851.0 3613.5 3736.6 3748.6 3751.8 3759.1 3662.2 3747.5 3829.4 3833.5 3860.5 3768.4 3776.2 3782.6 3813.5 3817.3 3526.2 3715.3 3777.8 3778.2 3785.3 3197.5 3198.2 3229.5 3234.0 3236.2 4688.5 4693.0 4697.2 4707.7 4766.6 4097.4 4217.4 4263.9 4267.9 4287.2 5010.7 5016.8 5027.7 5048.7 5062.3 3581.3 3588.2 3608.4 3611.6 3622.5 5182.3 5242.4 5244.3 5305.5 5342.6 3574.7 3615.7 3624.1 3629.1 3651.3 3639.4 3669.6 3677.0 3680.1 3692.9 4225.9 4229.8 4234.0 4251.9 4261.5 4977.5 5068.0 5068.7 5074.5 5102.8 1267.7 1277.3 1278.5 1282.3 1283.4 797.5 815.8 821.2 823.3 827.7 4358.9 4410.2 4459.0 4472.0 4500.9 5196.7 5200.4 5200.7 5200.8 5201.8 4444.9 4456.5 4465.7 4467.8 4471.9 2592.5 2784.4 2799.8 2801.1 2801.8 4929.8 4947.0 4949.7 4951.3 4963.2 5232.9 5318.8 5368.2 5387.9 5395.8 4861.6 4864.6 4889.8 4919.9 4951.2 5189.2 5226.6 5227.7 5239.7 5244.9 4891.6 5124.5 5146.4 5147.4 5171.7 4915.0 4919.1 4924.8 4925.9 4934.2 3692.7 3713.1 3727.6 3741.3 3744.3 5013.0 5240.9 5250.6 5253.5 5262.9 5076.6 5083.7 5098.6 5099.6 5101.6 5069.3 5079.8 5081.3 5090.0 5090.2 4666.7 4944.2 4951.8 4956.9 4966.8 4850.8 5006.5 5008.8 5015.5 5084.5 4882.9 4901.1 4910.6 5028.4 5031.1 06:14:17 INFO - PROCESS | 20764 | 06:14:17 INFO - PROCESS | 20764 | [#5] yui.html Cycles:180 Average:18068.75 Median:507.67 stddev:26772.57 (5273.6%) stddev-sans-first:26815.56 06:14:17 INFO - PROCESS | 20764 | Values: 605.0 660.9 668.6 680.7 683.7 12523.4 13579.7 13623.8 13627.9 13632.5 12482.6 12483.9 12657.9 12690.0 12904.5 634.1 756.2 765.3 786.6 786.7 772.0 784.2 786.8 787.0 787.5 803.1 803.6 804.7 804.8 805.1 657.6 669.4 669.4 676.4 795.5 581.1 601.2 603.2 603.4 604.5 11131.6 11136.5 11312.2 11348.7 11369.1 12038.5 12649.7 13410.5 13468.7 13521.5 11258.8 11386.2 11593.5 11661.2 11781.3 4289.6 4303.3 4367.7 4400.7 4464.3 58595.4 58886.7 58925.4 58975.7 59059.4 10418.7 10709.4 11050.5 11203.4 11232.1 19387.4 19488.7 19501.3 19507.2 19509.4 6415.1 6447.0 6586.3 6760.6 6796.6 3677.4 3677.6 3685.7 3720.6 3865.8 2859.2 2959.3 2963.0 2969.3 2972.9 515.1 537.9 570.5 572.8 579.1 500.2 553.9 555.3 568.1 577.9 7827.5 7942.8 8135.8 8228.3 8273.0 523.6 547.3 556.0 565.9 573.2 3966.9 4071.7 4094.2 4111.6 4151.9 98169.5 105676.0 105780.5 108010.5 109525.5 91787.0 93476.0 93581.5 93767.6 94223.0 42677.1 69569.0 73455.0 75372.0 78273.6 7608.5 7686.5 7706.4 7764.0 7778.1 47624.0 47788.8 48101.3 48337.0 49369.8 62872.7 65617.0 70455.6 72268.0 72563.3 10638.8 10688.0 10943.8 11012.3 11064.8 11558.7 11767.7 11898.6 12005.6 12555.4 10274.3 10711.3 10800.4 10809.4 10899.5 10086.8 10874.2 10919.3 11190.3 11219.5 10064.9 10159.6 10563.0 10884.6 10940.2 8366.2 8432.8 8526.5 8601.0 8743.9 7940.6 8334.7 9187.3 9194.5 9195.6 06:14:17 INFO - PROCESS | 20764 | -------- Summary: end -------- 06:14:17 INFO - PROCESS | 20764 | 06:14:18 INFO - TEST-INFO | 20764: exit 0 06:14:18 INFO - TEST-OK | dromaeo_css | took 1126427ms 06:14:18 INFO - TEST-START | kraken 06:14:18 INFO - operating with platform_type : linux_ 06:14:18 INFO - Initialising browser for kraken test... 06:14:18 INFO - TEST-INFO | started process 20955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5FfqN/profile http://localhost:39245/getInfo.html) 06:14:25 INFO - PROCESS | 20955 | __metrics Screen width/height:1600/1200 06:14:25 INFO - PROCESS | 20955 | colorDepth:24 06:14:25 INFO - PROCESS | 20955 | Browser inner width/height: 1024/697 06:14:25 INFO - PROCESS | 20955 | __metrics 06:14:26 INFO - PROCESS | 20955 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:27 INFO - PROCESS | 20955 | console.error: PushService: 06:14:27 INFO - PROCESS | 20955 | stateChangeProcessEnqueue: Error transitioning state 06:14:27 INFO - PROCESS | 20955 | UnknownError 06:14:28 INFO - TEST-INFO | 20955: exit 0 06:14:28 INFO - Browser initialized. 06:14:28 INFO - Running cycle 1/1 for kraken test... 06:14:28 INFO - TEST-INFO | started process 21037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5FfqN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:40 INFO - PROCESS | 21037 | RSS: Main: 159129600 06:14:40 INFO - PROCESS | 21037 | 06:14:42 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39245/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:43 INFO - PROCESS | 21037 | RSS: Main: 217182208 06:14:43 INFO - PROCESS | 21037 | 06:14:46 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39245/tests/kraken/driver.html?testName=audio-dft) 06:14:47 INFO - PROCESS | 21037 | RSS: Main: 203825152 06:14:47 INFO - PROCESS | 21037 | 06:14:50 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39245/tests/kraken/driver.html?testName=audio-fft) 06:14:50 INFO - PROCESS | 21037 | RSS: Main: 271536128 06:14:50 INFO - PROCESS | 21037 | 06:14:53 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39245/tests/kraken/driver.html?testName=audio-oscillator) 06:14:53 INFO - PROCESS | 21037 | RSS: Main: 181673984 06:14:53 INFO - PROCESS | 21037 | 06:14:55 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:56 INFO - PROCESS | 21037 | RSS: Main: 185925632 06:14:56 INFO - PROCESS | 21037 | 06:14:59 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39245/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:00 INFO - PROCESS | 21037 | RSS: Main: 222461952 06:15:00 INFO - PROCESS | 21037 | 06:15:03 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39245/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:04 INFO - PROCESS | 21037 | RSS: Main: 222371840 06:15:04 INFO - PROCESS | 21037 | 06:15:07 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39245/tests/kraken/driver.html?testName=json-parse-financial) 06:15:07 INFO - PROCESS | 21037 | RSS: Main: 222482432 06:15:07 INFO - PROCESS | 21037 | 06:15:09 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:10 INFO - PROCESS | 21037 | RSS: Main: 209625088 06:15:10 INFO - PROCESS | 21037 | 06:15:12 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:12 INFO - PROCESS | 21037 | RSS: Main: 214573056 06:15:12 INFO - PROCESS | 21037 | 06:15:14 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:15 INFO - PROCESS | 21037 | RSS: Main: 213176320 06:15:15 INFO - PROCESS | 21037 | 06:15:18 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:18 INFO - PROCESS | 21037 | RSS: Main: 224727040 06:15:18 INFO - PROCESS | 21037 | 06:15:21 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:22 INFO - PROCESS | 21037 | RSS: Main: 225980416 06:15:22 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | Cycle 1(1): loaded http://localhost:39245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39245/tests/kraken/driver.html?testName=ai-astar) 06:15:24 INFO - PROCESS | 21037 | RSS: Main: 268673024 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | __start_tp_report 06:15:24 INFO - PROCESS | 21037 | _x_x_mozilla_page_load 06:15:24 INFO - PROCESS | 21037 | _x_x_mozilla_page_load_details 06:15:24 INFO - PROCESS | 21037 | |i|pagename|runs| 06:15:24 INFO - PROCESS | 21037 | |0;ai-astar;107;117;117;114;114;115;114;113;114;114 06:15:24 INFO - PROCESS | 21037 | |1;audio-beat-detection;152;128;124;183;125;125;149;120;191;124 06:15:24 INFO - PROCESS | 21037 | |2;audio-dft;163;162;160;162;160;172;162;162;161;161 06:15:24 INFO - PROCESS | 21037 | |3;audio-fft;76;77;79;124;75;76;75;83;108;75 06:15:24 INFO - PROCESS | 21037 | |4;audio-oscillator;84;88;117;84;85;85;123;84;84;125 06:15:24 INFO - PROCESS | 21037 | |5;imaging-gaussian-blur;116;117;117;117;116;117;116;117;117;116 06:15:24 INFO - PROCESS | 21037 | |6;imaging-darkroom;147;147;146;146;145;148;146;146;145;147 06:15:24 INFO - PROCESS | 21037 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;95;95 06:15:24 INFO - PROCESS | 21037 | |8;json-parse-financial;64;63;63;62;63;63;63;62;62;63 06:15:24 INFO - PROCESS | 21037 | |9;json-stringify-tinderbox;65;65;64;64;65;65;64;65;65;65 06:15:24 INFO - PROCESS | 21037 | |10;stanford-crypto-aes;85;79;78;79;78;80;78;78;87;83 06:15:24 INFO - PROCESS | 21037 | |11;stanford-crypto-ccm;142;129;130;138;143;139;128;130;172;131 06:15:24 INFO - PROCESS | 21037 | |12;stanford-crypto-pbkdf2;168;173;174;169;170;169;170;177;171;168 06:15:24 INFO - PROCESS | 21037 | |13;stanford-crypto-sha256-iterative;68;67;68;66;67;67;67;66;65;65 06:15:24 INFO - PROCESS | 21037 | __end_tp_report 06:15:24 INFO - PROCESS | 21037 | __start_cc_report 06:15:24 INFO - PROCESS | 21037 | _x_x_mozilla_cycle_collect,1899 06:15:24 INFO - PROCESS | 21037 | __end_cc_report 06:15:24 INFO - PROCESS | 21037 | __startTimestamp1467292524307__endTimestamp 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | ------- Summary: start ------- 06:15:24 INFO - PROCESS | 21037 | Number of tests: 14 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:2.77 (2.4%) stddev-sans-first:1.41 06:15:24 INFO - PROCESS | 21037 | Values: 107.0 117.0 117.0 114.0 114.0 115.0 114.0 113.0 114.0 114.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:138.50 stddev:26.11 (18.9%) stddev-sans-first:27.45 06:15:24 INFO - PROCESS | 21037 | Values: 152.0 128.0 124.0 183.0 125.0 125.0 149.0 120.0 191.0 124.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:3.47 (2.1%) stddev-sans-first:3.68 06:15:24 INFO - PROCESS | 21037 | Values: 163.0 162.0 160.0 162.0 160.0 172.0 162.0 162.0 161.0 161.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:17.05 (22.4%) stddev-sans-first:17.78 06:15:24 INFO - PROCESS | 21037 | Values: 76.0 77.0 79.0 124.0 75.0 76.0 75.0 83.0 108.0 75.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:17.93 (21.3%) stddev-sans-first:18.49 06:15:24 INFO - PROCESS | 21037 | Values: 84.0 88.0 117.0 84.0 85.0 85.0 123.0 84.0 84.0 125.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:15:24 INFO - PROCESS | 21037 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:15:24 INFO - PROCESS | 21037 | Values: 147.0 147.0 146.0 146.0 145.0 148.0 146.0 146.0 145.0 147.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:15:24 INFO - PROCESS | 21037 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 06:15:24 INFO - PROCESS | 21037 | Values: 64.0 63.0 63.0 62.0 63.0 63.0 63.0 62.0 62.0 63.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 06:15:24 INFO - PROCESS | 21037 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:3.31 (4.2%) stddev-sans-first:3.08 06:15:24 INFO - PROCESS | 21037 | Values: 85.0 79.0 78.0 79.0 78.0 80.0 78.0 78.0 87.0 83.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:138.50 stddev:13.15 (9.5%) stddev-sans-first:13.87 06:15:24 INFO - PROCESS | 21037 | Values: 142.0 129.0 130.0 138.0 143.0 139.0 128.0 130.0 172.0 131.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:170.50 stddev:2.92 (1.7%) stddev-sans-first:2.91 06:15:24 INFO - PROCESS | 21037 | Values: 168.0 173.0 174.0 169.0 170.0 169.0 170.0 177.0 171.0 168.0 06:15:24 INFO - PROCESS | 21037 | 06:15:24 INFO - PROCESS | 21037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 06:15:24 INFO - PROCESS | 21037 | Values: 68.0 67.0 68.0 66.0 67.0 67.0 67.0 66.0 65.0 65.0 06:15:24 INFO - PROCESS | 21037 | -------- Summary: end -------- 06:15:24 INFO - PROCESS | 21037 | 06:15:25 INFO - TEST-INFO | 21037: exit 0 06:15:25 INFO - TEST-OK | kraken | took 66842ms 06:15:25 INFO - SUITE-END | took 1193s 06:15:25 INFO - Completed test suite (00:19:53) 06:15:25 INFO - javascript benchmark 06:15:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.538203123437, 2567.1785028790787, 2601.154624746958, 2620.554505734025, 2627.579587266038, 4558.065596552707, 4654.3018547217935, 4671.065786842628, 4751.097291514614, 4789.521047895213, 4709.4348678158585, 4711.835085771999, 4740.834070807522, 4754.215554433515, 4769.594584460325, 4144.191882582898, 4291.785410729459, 4380.189664911985, 4400.691951563392, 4495.887602809939, 4415.712978656377, 4443.977780111095, 4457.59881610655, 4468.50846406895, 4494.528074552174, 4228.302330115543, 4278.101598664284, 4304.526502084768, 4362.672799540015, 4366.170427618742, 4277.786110694484, 4298.484181898161, 4308.3537469379535, 4339.370791235253, 4357.934630980538, 4329.415528903621, 4334.306510958231, 4344.9348259776125, 4386.407834942273, 4387.714798538085, 4646.930296045562, 4663.743494107823, 4703.15343238217, 4730.645201609893, 4773.832915847928, 5049.368828896388, 5093.1087059764395, 5104.566111880495, 5104.923426148611, 5119.25770763241, 5135.024345374367, 5138.409082955471, 5143.819966301199, 5149.356330458692, 5158.819441319573, 4644.907101857978, 4714.269288260325, 4746.335513028179, 4756.096341695067, 4841.15279826029, 5253.422123566481, 5282.075636763628, 5283.709395983258, 5296.020236256305, 5299.2845965794895, 4926.33494478248, 5007.524285192901, 5060.544550990428, 5061.266116413173, 5062.164742817394, 5030.723310217973, 5063.3923929128005, 5067.037262920034, 5069.44236134025, 5085.898282034413, 5018.89962200754, 5021.548060674557, 5031.874203144951, 5041.899162016739, 5075.492450754895, 4884.731339776346, 4930.605551555938, 5006.274090256892, 5018.673786203885, 5020.748962551857, 4341.15347507233, 4361.978190109029, 4364.716293440916, 4383.890402739957, 4411.867643970686, 3769.6795772359656, 3774.1885494618787, 3793.241351729665, 3819.732618716663, 3822.3119838429348, 4365.934510982338, 4389.824407023683, 4391.341298805205, 4420.690551661352, 4437.400950871655, 4969.602431805447, 5023.673461225082, 5030.647854650212, 5074.238864170404, 5079.923801142986, 4319.438472998553, 4335.436393268855, 4337.522872484024, 4339.522652508222, 4390.517043125254, 4571.725696458157, 4575.450945886515, 4575.565321294472, 4583.404157459576, 4624.329472226508, 4668.673192876466, 4684.882877927943, 4743.620510359232, 4775.2598347256235, 4786.1624215762795, 5094.821681241138, 5112.948870511247, 5121.1550094234035, 5124.154514505214, 5170.069387510284, 4789.640776941674, 4792.185328494094, 4798.424189097331, 4799.904001920012, 4855.36880205571, 4941.332920055746, 4953.2074868020945, 4998.550130488128, 5020.468757029141, 5035.219540971156, 5111.693298402108, 5115.335006449138, 5119.334486516729, 5120.359955005624, 5166.173412254021, 4810.158222311152, 4955.702657840397, 4959.454460009469, 4961.0, 4963.429205641253, 4878.56092951636, 4916.06594746997, 4917.606591472745, 4924.4090709115135, 4940.9505904941925, 4843.685160464559, 4844.103840789465, 4879.634027447884, 4908.680935739166, 4959.231319145538, 4815.30178124177, 4939.185034469272, 5067.417247016493, 5071.543561079373, 5104.132297509358, 4925.704457732548, 4926.088673595396, 4958.727270000185, 4963.776630051729, 4992.975035124801], "value": 4659.929199906617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2993547871597, 584.4652143288889, 584.7281014328337, 587.9000569903113, 594.5570549940295, 27450.313742156457, 42625.57374426255, 44146.99999999992, 44173.558264417385, 44266.33600495995, 40049.59950400495, 40366.798166009205, 40389.79805100978, 40404.0, 40474.0, 7389.482736208468, 7879.093904201004, 8015.7194498192575, 8017.198280171994, 8019.318357939582, 10052.246081543914, 10310.793784124313, 10318.638847640334, 10635.627753028646, 10660.573577056908, 10133.797324053514, 10149.492525373738, 10150.0864922157, 10181.083702466776, 10254.948725256401, 7457.925420745777, 9899.109080182781, 9941.254405919513, 10158.28891977562, 10429.68710938673, 10174.287799854013, 10242.846357304647, 10267.486625668687, 10271.126954208901, 10280.228982826318, 38005.809970949966, 38306.0, 38361.42457863134, 38388.23223535542, 38473.42289865654, 3242.0, 3387.728981681484, 3477.009052420048, 3500.982495087508, 3806.9619303807162, 29623.851880740458, 29666.85166574175, 29687.25781855471, 29759.851200744073, 29943.0, 3220.7584431167757, 3253.33306672134, 3274.67253274673, 3307.8676852926096, 3358.6809253120914, 242883.0, 243584.0, 243654.0, 244337.0, 245115.0, 31483.37033259322, 51155.0, 51367.74316128396, 51649.225261621104, 51679.48320516822, 32984.34031319408, 33131.0, 33521.66478335185, 33529.66470335265, 33583.664163358546, 11786.941065294619, 11876.703082422835, 11889.108316876269, 11975.700607484883, 12054.939725301318, 8760.386772925835, 10379.481025948824, 10532.631357902437, 10818.891811081945, 10829.133669306437, 7854.528728276207, 7896.565688887166, 7939.761807145795, 7971.60141992898, 7991.120976692559, 3096.7212950834532, 3110.377924415081, 3133.310671652233, 3165.920851978719, 3195.2810617611317, 850.3027517435644, 941.6562954521687, 976.3117002513211, 977.193815102529, 984.3011461862015, 27668.446631067265, 28352.149435516967, 28667.426651466852, 28817.56773648397, 28996.27509312284, 954.7660823098386, 958.6596758150896, 1004.7387679203314, 1014.1531820929459, 1041.9895801042044, 14550.854491455162, 15420.537383878502, 15443.459478918185, 15864.762028569581, 16129.83870161307, 406471.0, 407511.0, 408557.0, 409599.0, 409785.0, 49033.264501032514, 50041.24938125931, 50123.74938125286, 50125.74937125291, 50186.74906625444, 1063.0, 1128.7008942630046, 1174.3247632611112, 1200.2378489658954, 1217.945192466341, 26756.331091722863, 28542.0, 29221.41557168887, 29260.122196334145, 29539.556906645987, 40688.186236274516, 41120.79439602783, 41346.379804302356, 41445.0, 41448.3782743253, 316014.0, 319708.2335531444, 320572.0, 320796.9601519961, 321457.0, 21912.342629721134, 22259.77740222577, 22370.0, 22977.310680679606, 24315.39211519726, 40611.1877762449, 41028.589714102476, 42489.0, 43498.0, 44004.55995440004, 35794.64205357913, 36460.81769591241, 36628.0, 36695.26609467849, 36813.0, 36308.455373168894, 36406.81796591, 36936.59912105704, 36949.0, 37147.0, 33797.32405351928, 34531.654683453846, 34776.82611586926, 35070.0, 35124.473132902516, 32524.51213231851, 32846.34307313888, 33102.0, 33137.17157070996, 33482.66517334795, 24954.750452495242, 25175.37061573475, 25325.240242792745, 25371.873140634918, 25823.0], "value": 16918.784731941872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7191106948755, 373.1380511019545, 376.52745804015944, 379.79680870734165, 394.50095629029283, 12970.80543791844, 14580.708385832277, 17176.0, 17186.398476053342, 17199.054052027135, 15526.611834704137, 15549.455769048085, 15774.921125394385, 16226.10756408397, 16712.2479488423, 4902.803887844482, 5087.720175390352, 5105.285260063594, 5141.228815677641, 5142.202958541432, 3726.5341832270965, 5013.874653133683, 5672.744726487318, 5950.55370847186, 5994.190784244137, 5979.581429299951, 5990.2212712347555, 6001.819945401645, 6014.819555413323, 6023.36754640763, 5743.569232307573, 5968.403159684019, 5988.580799344048, 5989.580729348947, 5992.981193197167, 3364.3775901458307, 4957.7769000395065, 5261.815836445744, 5269.420363759983, 5272.868178295574, 20852.687209691867, 20928.0, 21168.153273869026, 21178.576428471497, 21501.892490537604, 1989.711491833676, 2047.3653167518116, 2158.287765037534, 2262.151693115082, 2526.5325914705836, 6387.489000879965, 6408.487321014354, 6413.422791948747, 11763.7059073523, 13105.33365866774, 1679.9160041997852, 1705.8294170582967, 1758.674645190631, 1847.2795609712223, 1875.6061227142316, 55404.32505895989, 56383.71808140933, 57158.42841571572, 66379.3362066378, 69957.0, 9371.390859594105, 10245.590176392861, 10272.691819245434, 10461.529231184615, 10472.319299245524, 14018.789718154236, 14123.152610843383, 14131.505397311044, 14149.434022639185, 14156.433742650384, 7067.89398159028, 7211.603361815046, 7393.149787774367, 7440.10718713747, 7457.813554661068, 7019.508634395544, 7054.08296921397, 7062.505624606331, 7134.785956421316, 7137.964310178416, 4440.977795111004, 4450.5549445055885, 4485.080558485568, 4494.617957473652, 4571.794269257892, 1791.5610675384614, 1811.5923917118544, 1818.3363072478714, 1823.881447705895, 1876.1088482970479, 829.4567058576642, 859.9895123230305, 872.6553011560399, 921.1433366968784, 926.4626516620344, 16446.177691115397, 17293.308267669152, 17629.647407052045, 17643.647127057386, 17804.732929006077, 837.2506606587192, 860.9225169734754, 871.5467956662627, 871.7210492642421, 884.5842454046588, 9456.763580910394, 9753.756156096013, 9754.0, 9832.852507212398, 9904.653337133166, 423198.0, 425322.0, 427906.0, 431308.0, 438975.0, 76672.0, 77101.6144919283, 77914.6104269475, 79655.60172199101, 80090.84403450918, 781.6990458673451, 843.6541018182515, 892.8437523433373, 893.3567831161554, 908.2688435809237, 15406.537803865454, 16019.919900400424, 16073.347897596766, 16118.0, 16405.83594164043, 35853.82073089618, 36925.0, 37933.81033094927, 40596.18807623772, 41219.1756164881, 51315.743421282656, 54975.0, 55620.721896390256, 56101.719491402284, 56195.43804561902, 7477.738279160203, 7763.10724266694, 7789.437126342731, 7821.256980586835, 8108.189181081844, 8414.83170336602, 11188.328700278009, 11199.776004480027, 11227.494762735532, 11941.283522988648, 10101.747456313651, 10161.237907156845, 10161.644342447978, 10297.17622590206, 10478.056974871994, 10422.322549034288, 10526.263161578616, 10693.144548436261, 10763.623273185402, 10800.351978881292, 10352.275340726379, 10578.312409693654, 10737.0, 10753.946230268799, 10845.295055821347, 7903.446758726834, 8038.075621303625, 8038.39712021589, 8053.154418786177, 8158.021037475541, 9110.316726245426, 10072.395656260647, 10396.0, 10686.679399618024, 10808.18938579594], "value": 8295.29481281515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.3152589468211, 1425.06658138919, 1505.2398538737937, 1688.333108422174, 1740.7736994190752, 7625.885611715822, 8052.51684898905, 8105.432619716622, 8108.0, 8118.2693557579805, 6938.965305173467, 7494.325510704036, 7733.883991740115, 7744.341730952861, 7955.284024437799, 2148.205164089289, 2208.8232941364654, 2210.0386331945574, 2213.50196205854, 2215.3907675389314, 2162.4485756132162, 2171.326888664519, 2192.550527141932, 2196.934091977243, 2197.7252843394576, 1910.42687193842, 2167.295628920599, 2213.1700612270397, 2220.7785717855195, 2224.4883676754357, 2187.387531491185, 2187.671849222613, 2209.834262430324, 2210.403191138392, 2232.598132336179, 2182.8035476807163, 2189.200941656284, 2190.496185877257, 2191.1783081344497, 2193.5393567350875, 7810.726624568169, 7861.528308301463, 7864.174261702496, 7875.566843823587, 7879.724209652634, 4330.978345108286, 4456.331550267453, 4500.144972455223, 4560.931586026212, 4565.406497155382, 2772.916812495608, 2814.8311101333984, 2888.725571070766, 2910.738033576988, 2914.417116576693, 937.9108984646448, 943.7593413679537, 954.9379290346175, 957.2676902169845, 963.657901444984, 9832.213422926148, 9849.458279794608, 9862.852057219076, 9863.60545578176, 9965.501724913798, 3945.8027098645525, 4006.6193711597352, 4165.271077561475, 4168.854090106832, 4175.248455278079, 8480.703175388831, 8526.914730852735, 8532.018817835904, 8537.0, 8545.401821872534, 4274.316109422478, 4325.6106950374615, 4337.262665346899, 4337.50118736343, 4341.522432532419, 3925.9214815703526, 3927.666148377363, 3933.233019561158, 3944.3097457944746, 3944.546377166605, 3540.362734707726, 3580.695640870555, 3582.4089025311055, 3627.7460577759302, 3643.5809881863397, 1052.884182739898, 1126.245415571569, 1146.896779289868, 1162.0587324267372, 1163.0463020323255, 751.8084782858017, 782.4757412533617, 798.7124635131348, 832.5213002523573, 863.9740807775777, 5229.346331708536, 5281.0758117329315, 5375.462453754593, 5404.216388623706, 5414.3232095988005, 879.8284334554701, 904.5884122724144, 914.8581969794692, 933.7665583604099, 943.9197668198143, 3450.689437950546, 3591.982040089783, 3595.406757884972, 3618.7466877318334, 3634.909127271839, 9654.71035868911, 9774.071463210983, 9821.705348839547, 9935.254855885838, 9985.650502232533, 8459.957700211582, 9142.725718228463, 9611.807763844685, 9871.851922221173, 9873.111419972238, 7010.404115650125, 7283.672234749449, 7289.416846652255, 7361.0, 7415.998840156618, 5282.577393808563, 5353.464653534771, 5451.20957461158, 5490.5607551395, 5534.169874518854, 8749.606267717842, 8930.240929521064, 8956.776080598038, 9058.275337972815, 9111.908880911371, 9060.592273347584, 9098.454092754457, 9101.590428430869, 9224.677136300197, 9338.439693618404, 6929.307069293232, 7054.08296921397, 7089.82275443118, 7113.181984071898, 7121.0, 7315.963420182865, 7562.432817538816, 7572.432067594842, 7618.314351708373, 7685.077790664933, 7037.26108758573, 7083.362497375261, 7154.642267886481, 7179.066721326194, 7194.0647715798705, 6872.553284036521, 6929.133858267716, 7023.824404389931, 7038.612876291853, 7052.294770522906, 6200.782972595937, 6237.656928868956, 6280.591761535486, 6292.465140463112, 6294.370562943669, 4265.232258193555, 4340.110277393063, 4381.430414046154, 4424.7123936944, 4466.263066593976, 4328.696991210585, 4330.285502891988, 4456.331550267486, 4502.707324023928, 4506.301523263899], "value": 4126.819280378347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.60241475215827, 300.62421972534327, 302.57639304973037, 302.7698948798913, 306.47286666932865, 4828.493008234138, 4875.683565437339, 4888.926666100003, 4889.144399730047, 4937.925931111027, 4799.1841386964215, 4817.6145908327335, 4837.782299796509, 4842.249451335048, 4851.0, 3613.5121758562586, 3736.5889752127246, 3748.625137486243, 3751.756135851161, 3759.0978165240417, 3662.249238906031, 3747.4566187902738, 3829.3681542545587, 3833.463315135883, 3860.4981352424147, 3768.3970564709653, 3776.188119554295, 3782.6217378262227, 3813.504244448218, 3817.2747178036225, 3526.2418580005165, 3715.256948610289, 3777.7922214278206, 3778.1688028633657, 3785.261873934584, 3197.536357228212, 3198.200449887528, 3229.450993331139, 3233.983830080858, 3236.223306406469, 4688.507706690816, 4693.0, 4697.201475749131, 4707.741074240916, 4766.594839438651, 4097.44684467596, 4217.367394890791, 4263.893402664927, 4267.91464170718, 4287.164003019412, 5010.722265822228, 5016.774245158977, 5027.698338099725, 5048.671836330664, 5062.291279220912, 3581.2658405026905, 3588.1926566522584, 3608.4046132388125, 3611.56661200655, 3622.492851000862, 5182.32629758129, 5242.423333433358, 5244.2956039287, 5305.469453054702, 5342.626016178869, 3574.749767516301, 3615.728820338485, 3624.0758606555687, 3629.074585980558, 3651.342758303531, 3639.3994990826745, 3669.5596528416227, 3676.963230367662, 3680.0983758979223, 3692.9446058309145, 4225.859018065105, 4229.830806767694, 4234.0, 4251.873253587802, 4261.4673165854265, 4977.452480227172, 5068.0, 5068.670536415121, 5074.49255074497, 5102.770375333044, 1267.7401132767761, 1277.2591896699892, 1278.4630455208835, 1282.2755143343982, 1283.3508941010757, 797.4696826610356, 815.8368326334638, 821.1952286759009, 823.3413269384469, 827.6937533112787, 4358.891027724332, 4410.2282100632265, 4458.977705111519, 4471.977640111843, 4500.887477813081, 5196.714180720097, 5200.427952925251, 5200.6879587224885, 5200.76596553156, 5201.765920533585, 4444.911101777946, 4456.487503937024, 4465.732056076646, 4467.821287148543, 4471.910561788746, 2592.546304396723, 2784.4013537089622, 2799.846008469513, 2801.131649188758, 2801.7898657600763, 4929.802807887644, 4946.975265123651, 4949.727764972961, 4951.306817045616, 4963.181075122564, 5232.92150617741, 5318.760655770422, 5368.221607866837, 5387.9461205388225, 5395.81114660985, 4861.562459378673, 4864.562189402829, 4889.755512224446, 4919.925046845721, 4951.183054795918, 5189.221616757365, 5226.581873450039, 5227.71920879387, 5239.659422137549, 5244.868878278074, 4891.584215341736, 5124.461931497139, 5146.426786606697, 5147.433782283871, 5171.663841850268, 4915.0415668944215, 4919.139150648693, 4924.8276310328965, 4925.926111108264, 4934.161192597196, 3692.6861216796874, 3713.1088538751046, 3727.571329297057, 3741.28915506053, 3744.3260213161893, 5013.006612521981, 5240.868978275574, 5250.606204534599, 5253.529011876681, 5262.921056184084, 5076.593872490266, 5083.694978301313, 5098.617603679813, 5099.643024988215, 5101.642884998163, 5069.290299358019, 5079.796808127781, 5081.263216833612, 5090.0, 5090.185570308733, 4666.673332866802, 4944.159492886146, 4951.801927922843, 4956.900861982668, 4966.826161084345, 4850.83022094225, 5006.49935006511, 5008.774605142705, 5015.548600625962, 5084.466131056186, 4882.853514394574, 4901.142300097397, 4910.582600479, 5028.44118323321, 5031.144705400164], "value": 3801.38097075027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.0172648841212, 660.9074729537863, 668.5954997226675, 680.707295862779, 683.7367613468813, 12523.373831308432, 13579.728405431886, 13623.79564306535, 13627.931860340697, 13632.522861699843, 12482.625521234377, 12483.937580312086, 12657.873421265784, 12690.0, 12904.548340808074, 634.1027446163696, 756.2059837170976, 765.3456294867891, 786.5595266650665, 786.7207141464755, 772.038811679457, 784.1844481739013, 786.830831371255, 787.0044393841795, 787.4920676163871, 803.052398170159, 803.5500119932827, 804.6861723927673, 804.7907544038563, 805.0500409516768, 657.6481582353442, 669.3707914560298, 669.3741351836048, 676.4182802789597, 795.5067857928063, 581.0557843504306, 601.1523751510393, 603.2067830802481, 603.432773193197, 604.4741075264548, 11131.610393636183, 11136.498857551429, 11312.151588630803, 11348.716282093013, 11369.090472762242, 12038.518459261619, 12649.747005059939, 13410.530631427853, 13468.663283417993, 13521.526746563823, 11258.774824503545, 11386.202965792398, 11593.478293476814, 11661.242019268806, 11781.293122412682, 4289.613934745857, 4303.33298338758, 4367.737935723867, 4400.669949753749, 4464.285714285731, 58595.41404585942, 58886.70556647232, 58925.41074589285, 58975.705121474544, 59059.40940590582, 10418.739531511774, 10709.357438553712, 11050.502727377287, 11203.383813890152, 11232.10143188543, 19387.4183774487, 19488.70766938497, 19501.317453889045, 19507.219711211677, 19509.414717558495, 6415.101885736, 6447.0, 6586.341365863375, 6760.560563563353, 6796.558223715541, 3677.42999835026, 3677.595464498903, 3685.6867166291167, 3720.5535335759882, 3865.768053916774, 2859.1994241612383, 2959.334149816274, 2963.0, 2969.302213979713, 2972.866221020016, 515.1242887091959, 537.9435159308294, 570.4523657288966, 572.802383177803, 579.0532479396218, 500.20966872341614, 553.9113741801373, 555.2920026965651, 568.0967262053355, 577.8584246859547, 7827.491213071132, 7942.801429964182, 8135.79660508492, 8228.259456648811, 8272.958635206905, 523.5628250410873, 547.3295213363677, 555.9555235581144, 565.9066254068115, 573.1689050876246, 3966.861159859391, 4071.7353372030725, 4094.201630682048, 4111.578675102748, 4151.896202594899, 98169.50915245379, 105676.0, 105780.47109764555, 108010.45994769975, 109525.45237273762, 91787.0, 93476.0, 93581.5320923391, 93767.59348609776, 94223.0, 42677.14645707068, 69569.0, 73455.0, 75372.0, 78273.60863195648, 7608.505447146139, 7686.500377475446, 7706.422018348759, 7764.0, 7778.105517865518, 47624.0, 47788.761056195886, 48101.278480823516, 48337.0, 49369.753151234014, 62872.68563657152, 65617.0, 70455.64772176312, 72268.0, 72563.27436725565, 10638.787224255626, 10688.0, 10943.781124377627, 11012.339259644446, 11064.834027489433, 11558.653240402802, 11767.705807354885, 11898.583549575724, 12005.579804707142, 12555.43500542496, 10274.280800343904, 10711.303765255234, 10800.405977671304, 10809.35143891369, 10899.455027248447, 10086.8486972694, 10874.23880328401, 10919.290246133976, 11190.32858028521, 11219.495122719334, 10064.949675251577, 10159.593616255266, 10563.049325560736, 10884.619038333936, 10940.1794865387, 8366.163383661586, 8432.789180270542, 8526.488410695378, 8601.0, 8743.912560874563, 7940.6426710796995, 8334.749957501284, 9187.265018798615, 9194.540272986458, 9195.632174713204], "value": 6482.9109809155925, "unit": "score"}], "name": "dromaeo_css", "value": 6365.4032536851755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 124.0, 183.0, 125.0, 125.0, 149.0, 120.0, 191.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 162.0, 160.0, 172.0, 162.0, 162.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 124.0, 75.0, 76.0, 75.0, 83.0, 108.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 117.0, 84.0, 85.0, 85.0, 123.0, 84.0, 84.0, 125.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 148.0, 146.0, 146.0, 145.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 78.0, 79.0, 78.0, 80.0, 78.0, 78.0, 87.0, 83.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 129.0, 130.0, 138.0, 143.0, 139.0, 128.0, 130.0, 172.0, 131.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 174.0, 169.0, 170.0, 169.0, 170.0, 177.0, 171.0, 168.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 65.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1541.1000000000001, "alertThreshold": 2.0}]} 06:15:26 INFO - Return code: 0 06:15:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:26 INFO - # TBPL SUCCESS # 06:15:26 INFO - Running post-action listener: _resource_record_post_action 06:15:26 INFO - ##### 06:15:26 INFO - ##### Finished run-tests step (success) 06:15:26 INFO - ##### 06:15:26 INFO - Running post-run listener: _resource_record_post_run 06:15:26 INFO - Total resource usage - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539529216; Read time: 1216; Write time: 2779968 06:15:26 INFO - TinderboxPrint: CPU usage
13.2% 06:15:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 1,216 06:15:26 INFO - TinderboxPrint: I/O write bytes / time
539,529,216 / 2,779,968 06:15:26 INFO - TinderboxPrint: CPU idle
8,422.7 (86.8%) 06:15:26 INFO - TinderboxPrint: CPU user
1,200.1 (12.4%) 06:15:26 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:26 INFO - install - Wall time: 20s; CPU: 23.0%; Read bytes: 0; Write bytes: 192528384; Read time: 0; Write time: 1240204 06:15:26 INFO - run-tests - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331272192; Read time: 1216; Write time: 1320816 06:15:26 INFO - Running post-run listener: _upload_blobber_files 06:15:26 INFO - Blob upload gear active. 06:15:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:26 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 06:15:26 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'] 06:15:26 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 06:15:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:27 INFO - (blobuploader) - INFO - Done attempting. 06:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:32 INFO - (blobuploader) - INFO - Done attempting. 06:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:33 INFO - (blobuploader) - INFO - Done attempting. 06:15:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:33 INFO - Return code: 0 06:15:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acf75f57cc847b8ff997ff640f62ffe4d9b681df106bdfdf99083fc39d690c95ed066427b5d36c46890967006eda842aa064b394469e7eac99b63d507bd7d627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e75acc8c63b3f7a1aecd95d650964d982ea7fae8bbc584151c310c82445fe0f8a43c80b13ad15670b9e4f8fdd295fbedd6b041607f2d4c0f43b2b49674b7096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c698a428915e437eda45c59c439df6f4f8fccc6b7147e50e7830f8d304d334f4460ae5ba40d6813361230dc5754291c7dbd6081b7e53c07ad7369bd51b9e40"} 06:15:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:33 INFO - Contents: 06:15:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acf75f57cc847b8ff997ff640f62ffe4d9b681df106bdfdf99083fc39d690c95ed066427b5d36c46890967006eda842aa064b394469e7eac99b63d507bd7d627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e75acc8c63b3f7a1aecd95d650964d982ea7fae8bbc584151c310c82445fe0f8a43c80b13ad15670b9e4f8fdd295fbedd6b041607f2d4c0f43b2b49674b7096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c698a428915e437eda45c59c439df6f4f8fccc6b7147e50e7830f8d304d334f4460ae5ba40d6813361230dc5754291c7dbd6081b7e53c07ad7369bd51b9e40"} 06:15:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:33 INFO - Copying logs to upload dir... 06:15:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.867190 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-30 06:15:33.527063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 06:15:33.533731) ========= 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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 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/acf75f57cc847b8ff997ff640f62ffe4d9b681df106bdfdf99083fc39d690c95ed066427b5d36c46890967006eda842aa064b394469e7eac99b63d507bd7d627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e75acc8c63b3f7a1aecd95d650964d982ea7fae8bbc584151c310c82445fe0f8a43c80b13ad15670b9e4f8fdd295fbedd6b041607f2d4c0f43b2b49674b7096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c698a428915e437eda45c59c439df6f4f8fccc6b7147e50e7830f8d304d334f4460ae5ba40d6813361230dc5754291c7dbd6081b7e53c07ad7369bd51b9e40"} build_url:https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/QZ3iSZTZQPeXw72s1wlHRQ/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/acf75f57cc847b8ff997ff640f62ffe4d9b681df106bdfdf99083fc39d690c95ed066427b5d36c46890967006eda842aa064b394469e7eac99b63d507bd7d627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e75acc8c63b3f7a1aecd95d650964d982ea7fae8bbc584151c310c82445fe0f8a43c80b13ad15670b9e4f8fdd295fbedd6b041607f2d4c0f43b2b49674b7096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c698a428915e437eda45c59c439df6f4f8fccc6b7147e50e7830f8d304d334f4460ae5ba40d6813361230dc5754291c7dbd6081b7e53c07ad7369bd51b9e40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 06:15:33.558807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:15:33.559194) ========= 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=33d5923976266a1c518c4bf7000001ab-1467291272.885183-1559759016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:15:33.948164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:15:33.948535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:15:33.948840) ========= ========= Total master_lag: 0.55 =========