builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1468431438.43 results: success (0) buildid: 20160713100543 builduid: 0c89fc95aa06430aa28c2dac3c52bf0a revision: 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.428515) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.428984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.429569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.488336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.488698) ========= 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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 10:37:18-- 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% 113M=0s 2016-07-13 10:37:18 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.637987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.638300) ========= 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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.690926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:18.691253) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 --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 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 --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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 10:37:18,879 truncating revision to first 12 chars 2016-07-13 10:37:18,879 Setting DEBUG logging. 2016-07-13 10:37:18,879 attempt 1/10 2016-07-13 10:37:18,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/395c5a486954?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 10:37:19,178 unpacking tar archive at: fx-team-395c5a486954/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:19.323414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:19.323716) ========= script_repo_revision: 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:19.324112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:19.324413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:37:19.344197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-13 10:37:19.344502) ========= /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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:37:19 INFO - MultiFileLogger online at 20160713 10:37:19 in /builds/slave/test 10:37:19 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 10:37:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:19 INFO - {'append_to_log': False, 10:37:19 INFO - 'base_work_dir': '/builds/slave/test', 10:37:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:37:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:19 INFO - 'branch': 'Fx-Team-Non-PGO', 10:37:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:19 INFO - 'config_files': ('talos/linux_config.py',), 10:37:19 INFO - 'default_actions': ('clobber', 10:37:19 INFO - 'read-buildbot-config', 10:37:19 INFO - 'download-and-extract', 10:37:19 INFO - 'populate-webroot', 10:37:19 INFO - 'create-virtualenv', 10:37:19 INFO - 'install', 10:37:19 INFO - 'run-tests'), 10:37:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:19 INFO - 'download_minidump_stackwalk': True, 10:37:19 INFO - 'download_symbols': 'ondemand', 10:37:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:19 INFO - 'installer_path': 'installer.exe', 10:37:19 INFO - 'log_level': 'info', 10:37:19 INFO - 'log_name': 'talos', 10:37:19 INFO - 'log_to_console': True, 10:37:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:37:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:37:19 INFO - 'opt_config_files': (), 10:37:19 INFO - 'pip_index': False, 10:37:19 INFO - 'sps_profile': False, 10:37:19 INFO - 'sps_profile_interval': 0, 10:37:19 INFO - 'suite': 'dromaeojs', 10:37:19 INFO - 'system_bits': '32', 10:37:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:19 INFO - 'title': 'talos-linux64-ix-008', 10:37:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:19 INFO - 'use_talos_json': True, 10:37:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:19 INFO - 'work_dir': 'build'} 10:37:19 INFO - ##### 10:37:19 INFO - ##### Running clobber step. 10:37:19 INFO - ##### 10:37:19 INFO - Running pre-action listener: _resource_record_pre_action 10:37:19 INFO - Running main action method: clobber 10:37:19 INFO - rmtree: /builds/slave/test/build 10:37:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:20 INFO - Running post-action listener: _resource_record_post_action 10:37:20 INFO - ##### 10:37:20 INFO - ##### Finished clobber step (success) 10:37:20 INFO - ##### 10:37:20 INFO - ##### 10:37:20 INFO - ##### Running read-buildbot-config step. 10:37:20 INFO - ##### 10:37:20 INFO - Running pre-action listener: _resource_record_pre_action 10:37:20 INFO - Running main action method: read_buildbot_config 10:37:20 INFO - Using buildbot properties: 10:37:20 INFO - { 10:37:20 INFO - "project": "", 10:37:20 INFO - "product": "firefox", 10:37:20 INFO - "script_repo_revision": "production", 10:37:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:37:20 INFO - "repository": "", 10:37:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:37:20 INFO - "buildid": "20160713100543", 10:37:20 INFO - "pgo_build": "False", 10:37:20 INFO - "basedir": "/builds/slave/test", 10:37:20 INFO - "buildnumber": 1804, 10:37:20 INFO - "slavename": "talos-linux64-ix-008", 10:37:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:37:20 INFO - "platform": "ubuntu64_hw", 10:37:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:37:20 INFO - "branch": "fx-team", 10:37:20 INFO - "repo_path": "integration/fx-team", 10:37:20 INFO - "revision": "395c5a486954a3f747ceb07dfc8f1ebd3d00cf60", 10:37:20 INFO - "stage_platform": "linux64", 10:37:20 INFO - "builduid": "0c89fc95aa06430aa28c2dac3c52bf0a", 10:37:20 INFO - "slavebuilddir": "test" 10:37:20 INFO - } 10:37:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:37:20 INFO - Running post-action listener: _resource_record_post_action 10:37:20 INFO - ##### 10:37:20 INFO - ##### Finished read-buildbot-config step (success) 10:37:20 INFO - ##### 10:37:20 INFO - ##### 10:37:20 INFO - ##### Running download-and-extract step. 10:37:20 INFO - ##### 10:37:20 INFO - Running pre-action listener: _resource_record_pre_action 10:37:20 INFO - Running main action method: download_and_extract 10:37:20 INFO - mkdir: /builds/slave/test/build/tests 10:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:20 INFO - https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:20 INFO - Downloaded 1361 bytes. 10:37:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:37:20 INFO - Using the following test package requirements: 10:37:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:37:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:37:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'jsshell-linux-x86_64.zip'], 10:37:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:37:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:37:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:37:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:37:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:37:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:20 INFO - https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:21 INFO - Downloaded 22755434 bytes. 10:37:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:37:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:37:23 INFO - Return code: 0 10:37:23 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 10:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:23 INFO - https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:24 INFO - Downloaded 22755434 bytes. 10:37:24 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'] 10:37:24 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 10:37:25 INFO - Return code: 0 10:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:25 INFO - https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:26 INFO - Downloaded 14403317 bytes. 10:37:26 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'] 10:37:26 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 10:37:27 INFO - Return code: 0 10:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:27 INFO - https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F67D-8VfSReJFjTOqCms5g/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 10:37:28 INFO - Downloaded 57050281 bytes. 10:37:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:37:28 INFO - mkdir: /builds/slave/test/properties 10:37:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:37:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:37:28 INFO - Contents: 10:37:28 INFO - build_url:https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:37:29 INFO - Running post-action listener: _resource_record_post_action 10:37:29 INFO - Running post-action listener: set_extra_try_arguments 10:37:29 INFO - ##### 10:37:29 INFO - ##### Finished download-and-extract step (success) 10:37:29 INFO - ##### 10:37:29 INFO - ##### 10:37:29 INFO - ##### Running populate-webroot step. 10:37:29 INFO - ##### 10:37:29 INFO - Running pre-action listener: _resource_record_pre_action 10:37:29 INFO - Running main action method: populate_webroot 10:37:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:37:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:37:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:37:29 INFO - '--tppagecycles', 10:37:29 INFO - '7'], 10:37:29 INFO - 'tests': ['tsvgm']}}, 10:37:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:37:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:37:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:37:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:37:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['damp', 'tps']}, 10:37:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'tests': ['damp', 'tps']}, 10:37:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['dromaeo_dom']}, 10:37:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:37:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['basic_compositor_video']}, 10:37:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:37:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['a11yr', 10:37:29 INFO - 'ts_paint', 10:37:29 INFO - 'tpaint', 10:37:29 INFO - 'sessionrestore', 10:37:29 INFO - 'sessionrestore_no_auto_restore', 10:37:29 INFO - 'tabpaint']}, 10:37:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['tsvgx', 10:37:29 INFO - 'tsvgr_opacity', 10:37:29 INFO - 'tart', 10:37:29 INFO - 'tscrollx', 10:37:29 INFO - 'cart']}, 10:37:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:37:29 INFO - 'tsvgr_opacity', 10:37:29 INFO - 'tart', 10:37:29 INFO - 'tscrollx', 10:37:29 INFO - 'cart']}, 10:37:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'talos_options': ['--disable-e10s'], 10:37:29 INFO - 'tests': ['tp5o']}, 10:37:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'tests': ['tp5o']}, 10:37:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'talos_options': ['--disable-e10s', 10:37:29 INFO - '--xperf_path', 10:37:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:29 INFO - 'tests': ['tp5n']}, 10:37:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:29 INFO - 'talos_options': ['--xperf_path', 10:37:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:29 INFO - 'tests': ['tp5n']}}, 10:37:29 INFO - 'talos.zip': {'path': '', 10:37:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:37:29 INFO - Running post-action listener: _resource_record_post_action 10:37:29 INFO - ##### 10:37:29 INFO - ##### Finished populate-webroot step (success) 10:37:29 INFO - ##### 10:37:29 INFO - ##### 10:37:29 INFO - ##### Running create-virtualenv step. 10:37:29 INFO - ##### 10:37:29 INFO - Running pre-action listener: _resource_record_pre_action 10:37:29 INFO - Running main action method: create_virtualenv 10:37:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:37:29 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 10:37:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:37:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:37:29 INFO - Using real prefix '/usr' 10:37:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:37:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:37:31 INFO - Installing pip.................done. 10:37:31 INFO - Return code: 0 10:37:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:37:31 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')]} 10:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:31 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')]} 10:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:31 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:31 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 10:37:31 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 10:37:31 INFO - Using env: {'DISPLAY': ':0', 10:37:31 INFO - 'HOME': '/home/cltbld', 10:37:31 INFO - 'LANG': 'en_US.UTF-8', 10:37:31 INFO - 'LANGUAGE': 'en_US:en', 10:37:31 INFO - 'LOGNAME': 'cltbld', 10:37:31 INFO - 'MAIL': '/var/mail/cltbld', 10:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:31 INFO - 'MOZ_NO_REMOTE': '1', 10:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:31 INFO - 'NO_EM_RESTART': '1', 10:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:31 INFO - 'PWD': '/builds/slave/test', 10:37:31 INFO - 'SHELL': '/bin/bash', 10:37:31 INFO - 'SHLVL': '1', 10:37:31 INFO - 'TERM': 'linux', 10:37:31 INFO - 'TMOUT': '86400', 10:37:31 INFO - 'USER': 'cltbld', 10:37:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:31 INFO - '_': '/tools/buildbot/bin/python'} 10:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:32 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 10:37:32 INFO - Cleaning up... 10:37:32 INFO - Return code: 0 10:37:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:37:32 INFO - Using env: {'DISPLAY': ':0', 10:37:32 INFO - 'HOME': '/home/cltbld', 10:37:32 INFO - 'LANG': 'en_US.UTF-8', 10:37:32 INFO - 'LANGUAGE': 'en_US:en', 10:37:32 INFO - 'LOGNAME': 'cltbld', 10:37:32 INFO - 'MAIL': '/var/mail/cltbld', 10:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:32 INFO - 'MOZ_NO_REMOTE': '1', 10:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:32 INFO - 'NO_EM_RESTART': '1', 10:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:32 INFO - 'PWD': '/builds/slave/test', 10:37:32 INFO - 'SHELL': '/bin/bash', 10:37:32 INFO - 'SHLVL': '1', 10:37:32 INFO - 'TERM': 'linux', 10:37:32 INFO - 'TMOUT': '86400', 10:37:32 INFO - 'USER': 'cltbld', 10:37:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:32 INFO - '_': '/tools/buildbot/bin/python'} 10:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:32 INFO - Downloading/unpacking psutil>=3.1.1 10:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:34 INFO - Installing collected packages: psutil 10:37:34 INFO - Running setup.py install for psutil 10:37:34 INFO - building 'psutil._psutil_linux' extension 10:37:34 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 10:37:34 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 10:37:34 INFO - building 'psutil._psutil_posix' extension 10:37:34 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 10:37:34 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 10:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:34 INFO - Successfully installed psutil 10:37:34 INFO - Cleaning up... 10:37:34 INFO - Return code: 0 10:37:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:37:34 INFO - Using env: {'DISPLAY': ':0', 10:37:34 INFO - 'HOME': '/home/cltbld', 10:37:34 INFO - 'LANG': 'en_US.UTF-8', 10:37:34 INFO - 'LANGUAGE': 'en_US:en', 10:37:34 INFO - 'LOGNAME': 'cltbld', 10:37:34 INFO - 'MAIL': '/var/mail/cltbld', 10:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:34 INFO - 'MOZ_NO_REMOTE': '1', 10:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:34 INFO - 'NO_EM_RESTART': '1', 10:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:34 INFO - 'PWD': '/builds/slave/test', 10:37:34 INFO - 'SHELL': '/bin/bash', 10:37:34 INFO - 'SHLVL': '1', 10:37:34 INFO - 'TERM': 'linux', 10:37:34 INFO - 'TMOUT': '86400', 10:37:34 INFO - 'USER': 'cltbld', 10:37:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:34 INFO - '_': '/tools/buildbot/bin/python'} 10:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:37:37 INFO - Installing collected packages: mozsystemmonitor 10:37:37 INFO - Running setup.py install for mozsystemmonitor 10:37:37 INFO - Successfully installed mozsystemmonitor 10:37:37 INFO - Cleaning up... 10:37:37 INFO - Return code: 0 10:37:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:37 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:37 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 10:37:37 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 10:37:37 INFO - Using env: {'DISPLAY': ':0', 10:37:37 INFO - 'HOME': '/home/cltbld', 10:37:37 INFO - 'LANG': 'en_US.UTF-8', 10:37:37 INFO - 'LANGUAGE': 'en_US:en', 10:37:37 INFO - 'LOGNAME': 'cltbld', 10:37:37 INFO - 'MAIL': '/var/mail/cltbld', 10:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:37 INFO - 'MOZ_NO_REMOTE': '1', 10:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:37 INFO - 'NO_EM_RESTART': '1', 10:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:37 INFO - 'PWD': '/builds/slave/test', 10:37:37 INFO - 'SHELL': '/bin/bash', 10:37:37 INFO - 'SHLVL': '1', 10:37:37 INFO - 'TERM': 'linux', 10:37:37 INFO - 'TMOUT': '86400', 10:37:37 INFO - 'USER': 'cltbld', 10:37:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:37 INFO - '_': '/tools/buildbot/bin/python'} 10:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:37 INFO - Downloading/unpacking jsonschema==2.5.1 10:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:39 INFO - warning: no files found matching '*.txt' 10:37:39 INFO - no previously-included directories found matching 'build' 10:37:39 INFO - no previously-included directories found matching 'dist' 10:37:39 INFO - no previously-included directories found matching '.git*' 10:37:39 INFO - Installing collected packages: jsonschema, functools32 10:37:39 INFO - Running setup.py install for functools32 10:37:39 INFO - warning: no files found matching '*.txt' 10:37:39 INFO - no previously-included directories found matching 'build' 10:37:39 INFO - no previously-included directories found matching 'dist' 10:37:39 INFO - no previously-included directories found matching '.git*' 10:37:39 INFO - Successfully installed jsonschema functools32 10:37:39 INFO - Cleaning up... 10:37:39 INFO - Return code: 0 10:37:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:39 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:39 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 10:37:39 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 10:37:39 INFO - Using env: {'DISPLAY': ':0', 10:37:39 INFO - 'HOME': '/home/cltbld', 10:37:39 INFO - 'LANG': 'en_US.UTF-8', 10:37:39 INFO - 'LANGUAGE': 'en_US:en', 10:37:39 INFO - 'LOGNAME': 'cltbld', 10:37:39 INFO - 'MAIL': '/var/mail/cltbld', 10:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:39 INFO - 'MOZ_NO_REMOTE': '1', 10:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:39 INFO - 'NO_EM_RESTART': '1', 10:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:39 INFO - 'PWD': '/builds/slave/test', 10:37:39 INFO - 'SHELL': '/bin/bash', 10:37:39 INFO - 'SHLVL': '1', 10:37:39 INFO - 'TERM': 'linux', 10:37:39 INFO - 'TMOUT': '86400', 10:37:39 INFO - 'USER': 'cltbld', 10:37:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:39 INFO - '_': '/tools/buildbot/bin/python'} 10:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:37:40 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 10:37:40 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 10:37:40 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 10:37:40 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 10:37:40 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 10:37:40 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 10:37:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:37:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:37:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 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 10:37:42 INFO - Downloading docopt-0.6.1.tar.gz 10:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:42 INFO - Running setup.py install for blobuploader 10:37:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:37:42 INFO - Running setup.py install for requests 10:37:43 INFO - Running setup.py install for docopt 10:37:43 INFO - Successfully installed blobuploader requests docopt 10:37:43 INFO - Cleaning up... 10:37:43 INFO - Return code: 0 10:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:43 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:43 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 10:37:43 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 10:37:43 INFO - Using env: {'DISPLAY': ':0', 10:37:43 INFO - 'HOME': '/home/cltbld', 10:37:43 INFO - 'LANG': 'en_US.UTF-8', 10:37:43 INFO - 'LANGUAGE': 'en_US:en', 10:37:43 INFO - 'LOGNAME': 'cltbld', 10:37:43 INFO - 'MAIL': '/var/mail/cltbld', 10:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:43 INFO - 'MOZ_NO_REMOTE': '1', 10:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:43 INFO - 'NO_EM_RESTART': '1', 10:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:43 INFO - 'PWD': '/builds/slave/test', 10:37:43 INFO - 'SHELL': '/bin/bash', 10:37:43 INFO - 'SHLVL': '1', 10:37:43 INFO - 'TERM': 'linux', 10:37:43 INFO - 'TMOUT': '86400', 10:37:43 INFO - 'USER': 'cltbld', 10:37:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:43 INFO - '_': '/tools/buildbot/bin/python'} 10:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:43 INFO - Running setup.py (path:/tmp/pip-mGQ7yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:43 INFO - Running setup.py (path:/tmp/pip-cEWQFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:43 INFO - Running setup.py (path:/tmp/pip-cB2Low-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:43 INFO - Running setup.py (path:/tmp/pip-4HAAwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:43 INFO - Running setup.py (path:/tmp/pip-814cP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:44 INFO - Running setup.py (path:/tmp/pip-DKRTJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:44 INFO - Running setup.py (path:/tmp/pip-AANb3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:44 INFO - Running setup.py (path:/tmp/pip-NgjhGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:44 INFO - Running setup.py (path:/tmp/pip-6NQSJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:44 INFO - Running setup.py (path:/tmp/pip-SRQ5_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:44 INFO - Running setup.py (path:/tmp/pip-UHbTvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:44 INFO - Running setup.py (path:/tmp/pip-3mzmvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:44 INFO - Running setup.py (path:/tmp/pip-5IcYp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:44 INFO - Running setup.py (path:/tmp/pip-XQjRDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:44 INFO - Running setup.py (path:/tmp/pip-npIzvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:44 INFO - Running setup.py (path:/tmp/pip-yt7Dh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:44 INFO - Running setup.py (path:/tmp/pip-ujzYIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:44 INFO - Running setup.py install for manifestparser 10:37:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for mozcrash 10:37:45 INFO - Running setup.py install for mozdebug 10:37:45 INFO - Running setup.py install for mozdevice 10:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for mozfile 10:37:45 INFO - Running setup.py install for mozhttpd 10:37:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for mozinfo 10:37:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for mozInstall 10:37:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for mozleak 10:37:45 INFO - Running setup.py install for mozlog 10:37:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:37:45 INFO - Running setup.py install for moznetwork 10:37:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Running setup.py install for mozprocess 10:37:46 INFO - Running setup.py install for mozprofile 10:37:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Running setup.py install for mozrunner 10:37:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Running setup.py install for mozscreenshot 10:37:46 INFO - Running setup.py install for moztest 10:37:46 INFO - Running setup.py install for mozversion 10:37:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:37:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:46 INFO - Cleaning up... 10:37:46 INFO - Return code: 0 10:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:46 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')]} 10:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:46 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')]} 10:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:46 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:46 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 10:37:46 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 10:37:46 INFO - Using env: {'DISPLAY': ':0', 10:37:46 INFO - 'HOME': '/home/cltbld', 10:37:46 INFO - 'LANG': 'en_US.UTF-8', 10:37:46 INFO - 'LANGUAGE': 'en_US:en', 10:37:46 INFO - 'LOGNAME': 'cltbld', 10:37:46 INFO - 'MAIL': '/var/mail/cltbld', 10:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:46 INFO - 'MOZ_NO_REMOTE': '1', 10:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:46 INFO - 'NO_EM_RESTART': '1', 10:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:46 INFO - 'PWD': '/builds/slave/test', 10:37:46 INFO - 'SHELL': '/bin/bash', 10:37:46 INFO - 'SHLVL': '1', 10:37:46 INFO - 'TERM': 'linux', 10:37:46 INFO - 'TMOUT': '86400', 10:37:46 INFO - 'USER': 'cltbld', 10:37:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:46 INFO - '_': '/tools/buildbot/bin/python'} 10:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:46 INFO - Running setup.py (path:/tmp/pip-TLU8il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:47 INFO - Running setup.py (path:/tmp/pip-qdni2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:47 INFO - Running setup.py (path:/tmp/pip-GhKEOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:47 INFO - Running setup.py (path:/tmp/pip-SQsZvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:47 INFO - Running setup.py (path:/tmp/pip-mqsFu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:47 INFO - Running setup.py (path:/tmp/pip-Kf9wJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:47 INFO - Running setup.py (path:/tmp/pip-ZeXhIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:47 INFO - Running setup.py (path:/tmp/pip-RDMplJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:47 INFO - Running setup.py (path:/tmp/pip-5iuQUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:47 INFO - Running setup.py (path:/tmp/pip-t8knoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:47 INFO - Running setup.py (path:/tmp/pip-SCgHu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:47 INFO - Running setup.py (path:/tmp/pip-H4IcI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:47 INFO - Running setup.py (path:/tmp/pip-DP1lST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:47 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)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:47 INFO - Running setup.py (path:/tmp/pip-rAe9HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:47 INFO - Running setup.py (path:/tmp/pip-UjVQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:48 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)) 10:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:48 INFO - Running setup.py (path:/tmp/pip-dOOd5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:48 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)) 10:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:48 INFO - Running setup.py (path:/tmp/pip-XgmeFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:48 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)) 10:37:48 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)) 10:37:48 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)) 10:37:48 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)) 10:37:48 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)) 10:37:48 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)) 10:37:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:50 INFO - Downloading blessings-1.6.tar.gz 10:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:50 INFO - Installing collected packages: blessings 10:37:50 INFO - Running setup.py install for blessings 10:37:50 INFO - Successfully installed blessings 10:37:50 INFO - Cleaning up... 10:37:50 INFO - Return code: 0 10:37:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:37:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:50 INFO - Reading from file tmpfile_stdout 10:37:50 INFO - Current package versions: 10:37:50 INFO - argparse == 1.2.1 10:37:50 INFO - blessings == 1.6 10:37:50 INFO - blobuploader == 1.2.4 10:37:50 INFO - docopt == 0.6.1 10:37:50 INFO - functools32 == 3.2.3-2 10:37:50 INFO - jsonschema == 2.5.1 10:37:50 INFO - manifestparser == 1.1 10:37:50 INFO - mozInstall == 1.12 10:37:50 INFO - mozcrash == 0.17 10:37:50 INFO - mozdebug == 0.1 10:37:50 INFO - mozdevice == 0.48 10:37:50 INFO - mozfile == 1.2 10:37:50 INFO - mozhttpd == 0.7 10:37:50 INFO - mozinfo == 0.9 10:37:50 INFO - mozleak == 0.1 10:37:50 INFO - mozlog == 3.2 10:37:50 INFO - moznetwork == 0.27 10:37:50 INFO - mozprocess == 0.23 10:37:50 INFO - mozprofile == 0.28 10:37:50 INFO - mozrunner == 6.12 10:37:50 INFO - mozscreenshot == 0.1 10:37:50 INFO - mozsystemmonitor == 0.3 10:37:50 INFO - moztest == 0.7 10:37:50 INFO - mozversion == 1.4 10:37:50 INFO - psutil == 3.1.1 10:37:50 INFO - requests == 1.2.3 10:37:50 INFO - wsgiref == 0.1.2 10:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:50 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')]} 10:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:50 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')]} 10:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:50 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:50 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 10:37:50 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 10:37:50 INFO - Using env: {'DISPLAY': ':0', 10:37:50 INFO - 'HOME': '/home/cltbld', 10:37:50 INFO - 'LANG': 'en_US.UTF-8', 10:37:50 INFO - 'LANGUAGE': 'en_US:en', 10:37:50 INFO - 'LOGNAME': 'cltbld', 10:37:50 INFO - 'MAIL': '/var/mail/cltbld', 10:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:50 INFO - 'MOZ_NO_REMOTE': '1', 10:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:50 INFO - 'NO_EM_RESTART': '1', 10:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:50 INFO - 'PWD': '/builds/slave/test', 10:37:50 INFO - 'SHELL': '/bin/bash', 10:37:50 INFO - 'SHLVL': '1', 10:37:50 INFO - 'TERM': 'linux', 10:37:50 INFO - 'TMOUT': '86400', 10:37:50 INFO - 'USER': 'cltbld', 10:37:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:50 INFO - '_': '/tools/buildbot/bin/python'} 10:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 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)) 10:37:50 INFO - Cleaning up... 10:37:50 INFO - Return code: 0 10:37:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:37:50 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')]} 10:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:50 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')]} 10:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:50 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 0xde8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, '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': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', '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 10:37:50 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 10:37:50 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 10:37:50 INFO - Using env: {'DISPLAY': ':0', 10:37:50 INFO - 'HOME': '/home/cltbld', 10:37:50 INFO - 'LANG': 'en_US.UTF-8', 10:37:50 INFO - 'LANGUAGE': 'en_US:en', 10:37:50 INFO - 'LOGNAME': 'cltbld', 10:37:50 INFO - 'MAIL': '/var/mail/cltbld', 10:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:50 INFO - 'MOZ_NO_REMOTE': '1', 10:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:50 INFO - 'NO_EM_RESTART': '1', 10:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:50 INFO - 'PWD': '/builds/slave/test', 10:37:50 INFO - 'SHELL': '/bin/bash', 10:37:50 INFO - 'SHLVL': '1', 10:37:50 INFO - 'TERM': 'linux', 10:37:50 INFO - 'TMOUT': '86400', 10:37:50 INFO - 'USER': 'cltbld', 10:37:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:50 INFO - '_': '/tools/buildbot/bin/python'} 10:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:37:50 INFO - Cleaning up... 10:37:50 INFO - Return code: 0 10:37:50 INFO - Running post-action listener: _resource_record_post_action 10:37:50 INFO - Running post-action listener: _start_resource_monitoring 10:37:50 INFO - Starting resource monitoring. 10:37:50 INFO - ##### 10:37:50 INFO - ##### Finished create-virtualenv step (success) 10:37:50 INFO - ##### 10:37:50 INFO - ##### 10:37:50 INFO - ##### Running install step. 10:37:50 INFO - ##### 10:37:50 INFO - Running pre-action listener: _resource_record_pre_action 10:37:50 INFO - Running main action method: install 10:37:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:51 INFO - Reading from file tmpfile_stdout 10:37:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:37:51 INFO - Reading from file tmpfile_stdout 10:37:51 INFO - Output received: 10:37:51 INFO - Usage: mozinstall [options] installer 10:37:51 INFO - Options: 10:37:51 INFO - -h, --help show this help message and exit 10:37:51 INFO - -d DEST, --destination=DEST 10:37:51 INFO - Directory to install application into. [default: 10:37:51 INFO - "/builds/slave/test"] 10:37:51 INFO - --app=APP Application being installed. [default: firefox] 10:37:51 INFO - mkdir: /builds/slave/test/build/application 10:37:51 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'] 10:37:51 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 10:38:07 INFO - Reading from file tmpfile_stdout 10:38:07 INFO - Output received: 10:38:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:07 INFO - Running post-action listener: _resource_record_post_action 10:38:07 INFO - ##### 10:38:07 INFO - ##### Finished install step (success) 10:38:07 INFO - ##### 10:38:07 INFO - ##### 10:38:07 INFO - ##### Running run-tests step. 10:38:07 INFO - ##### 10:38:07 INFO - Running pre-action listener: _resource_record_pre_action 10:38:07 INFO - Running main action method: run_tests 10:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:07 INFO - Python 2.7.3 10:38:07 INFO - Return code: 0 10:38:07 INFO - grabbing minidump binary from tooltool 10:38:07 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')]} 10:38:07 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 0x10a73b0>, '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 0x10a82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:07 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 10:38:07 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 10:38:07 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 10:38:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:07 INFO - Return code: 0 10:38:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:07 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/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:38:07 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/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 10:38:07 INFO - Using env: {'DISPLAY': ':0', 10:38:07 INFO - 'HOME': '/home/cltbld', 10:38:07 INFO - 'LANG': 'en_US.UTF-8', 10:38:07 INFO - 'LANGUAGE': 'en_US:en', 10:38:07 INFO - 'LOGNAME': 'cltbld', 10:38:07 INFO - 'MAIL': '/var/mail/cltbld', 10:38:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:07 INFO - 'MOZ_NO_REMOTE': '1', 10:38:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:07 INFO - 'NO_EM_RESTART': '1', 10:38:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:07 INFO - 'PWD': '/builds/slave/test', 10:38:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:07 INFO - 'SHELL': '/bin/bash', 10:38:07 INFO - 'SHLVL': '1', 10:38:07 INFO - 'TERM': 'linux', 10:38:07 INFO - 'TMOUT': '86400', 10:38:07 INFO - 'USER': 'cltbld', 10:38:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037', 10:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:07 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 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/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:38:07 INFO - mozversion application_buildid: 20160713100543 10:38:07 INFO - mozversion application_changeset: 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 10:38:07 INFO - mozversion application_display_name: Nightly 10:38:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:07 INFO - mozversion application_name: Firefox 10:38:07 INFO - mozversion application_remotingname: firefox 10:38:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:38:07 INFO - mozversion application_vendor: Mozilla 10:38:07 INFO - mozversion application_version: 50.0a1 10:38:07 INFO - mozversion platform_buildid: 20160713100543 10:38:07 INFO - mozversion platform_changeset: 395c5a486954a3f747ceb07dfc8f1ebd3d00cf60 10:38:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:38:07 INFO - mozversion platform_version: 50.0a1 10:38:07 INFO - using testdate: 1468431487 10:38:07 INFO - actual date: 1468431487 10:38:07 INFO - starting webserver on 'localhost:54730' 10:38:07 INFO - SUITE-START | Running 2 tests 10:38:07 INFO - TEST-START | dromaeo_css 10:38:07 INFO - operating with platform_type : linux_ 10:38:07 INFO - Initialising browser for dromaeo_css test... 10:38:07 INFO - TEST-INFO | started process 15855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dxDkU/profile http://localhost:54730/getInfo.html) 10:38:12 INFO - PROCESS | 15855 | __metrics Screen width/height:1600/1200 10:38:12 INFO - PROCESS | 15855 | colorDepth:24 10:38:12 INFO - PROCESS | 15855 | Browser inner width/height: 1024/697 10:38:12 INFO - PROCESS | 15855 | __metrics 10:38:13 INFO - PROCESS | 15855 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:38:13 INFO - PROCESS | 15855 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:38:13 INFO - PROCESS | 15855 | console.error: PushService: 10:38:13 INFO - PROCESS | 15855 | stateChangeProcessEnqueue: Error transitioning state 10:38:13 INFO - PROCESS | 15855 | UnknownError 10:38:13 INFO - TEST-INFO | 15855: exit 0 10:38:13 INFO - Browser initialized. 10:38:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:38:13 INFO - TEST-INFO | started process 15936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dxDkU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:25 INFO - PROCESS | 15936 | RSS: Main: 159305728 10:38:25 INFO - PROCESS | 15936 | 10:39:17 INFO - PROCESS | 15936 | 1468431557616 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] 10:41:28 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54730/tests/dromaeo/cssquery-ext.html) 10:41:30 INFO - PROCESS | 15936 | RSS: Main: 233762816 10:41:30 INFO - PROCESS | 15936 | 10:44:32 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-ext.html (next: http://localhost:54730/tests/dromaeo/cssquery-jquery.html) 10:44:33 INFO - PROCESS | 15936 | RSS: Main: 246132736 10:44:33 INFO - PROCESS | 15936 | 10:47:35 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54730/tests/dromaeo/cssquery-mootools.html) 10:47:36 INFO - PROCESS | 15936 | RSS: Main: 245018624 10:47:36 INFO - PROCESS | 15936 | 10:50:38 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54730/tests/dromaeo/cssquery-prototype.html) 10:50:38 INFO - PROCESS | 15936 | RSS: Main: 234790912 10:50:38 INFO - PROCESS | 15936 | 10:53:42 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54730/tests/dromaeo/cssquery-yui.html) 10:53:42 INFO - PROCESS | 15936 | RSS: Main: 218529792 10:53:42 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | Cycle 1(1): loaded http://localhost:54730/tests/dromaeo/cssquery-yui.html (next: http://localhost:54730/tests/dromaeo/cssquery-dojo.html) 10:56:45 INFO - PROCESS | 15936 | RSS: Main: 276652032 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | __start_tp_report 10:56:45 INFO - PROCESS | 15936 | _x_x_mozilla_page_load 10:56:45 INFO - PROCESS | 15936 | _x_x_mozilla_page_load_details 10:56:45 INFO - PROCESS | 15936 | |i|pagename|runs| 10:56:45 INFO - PROCESS | 15936 | |0;dojo.html;2574.317805781467;2580.7290234525376;2614.228802503262;2616.5159445502572;2624.291441310846;4468.128714900596;4499.505054444016;4577.244754615489;4604.44746630404;4607.884802879929;4576.588107070363;4579.38178345924;4603.7928293226805;4616.953830461694;4625.4680711718165;3927.4894263745673;4116.053307739229;4157.958420415803;4183.456150700405;4329.891752706192;4237.427947227131;4297.1405718856195;4298.548652391501;4311.676624253178;4339.761313127777;4117.2177286315655;4154.50145982481;4170.416141740159;4173.833046678129;4213.873583792491;4239.554846741079;4241.257779888538;4252.893677658052;4262.9786851065855;4270.210011147948;4244.236037513247;4282.314829627276;4293.8711838644895;4320.503142138663;4333.891652708676;4407.779611019436;4531.56950089741;4586.518415566351;4602.953970460319;4696.741679207642;4910.435299940516;4916.606671466274;4916.8770780730765;4947.455779864212;4949.851504454872;4914.508549145093;4938.1111399947995;4966.304717339575;4977.776000080005;4990.3762029746285;4457.866264012085;4573.954260457419;4593.19619066662;4618.145643055978;4671.789769460314;5095.414027386824;5110.310108135429;5115.283860259567;5120.641555091108;5128.8461346159675;4700.670953033255;4904.681195722266;4918.5573298403315;4924.162892308316;4926.039422312686;4851.587615052689;4890.364252647133;4904.901901961941;4926.802927882916;4932.704037757746;4856.660033797671;4878.802992518703;4890;4891.779869905863;4937.753112344369;4707.576318131316;4811.08589368019;4874.878128046827;4878.658493905393;4938.530839570235;4140.627343539096;4167.749935003849;4170.395292682605;4195.391668208093;4208.22147902639;3638.9636103639154;3652.6712595866497;3670.0457880951144;3695.519582454264;3714.851405943786;4087;4125.463689720377;4126.401671757639;4230.64039556635;4237.046664500463;4878.487758785276;4939.901201976012;4943.950560494421;4953.851384458472;4954.108260513142;4214.873553793391;4242.363645453207;4244.554321796167;4278.743275403485;4286.89282767927;4240.639545638655;4368.716033457878;4419.535948725402;4424.336349547593;4430.778461076933;4650.255959046536;4654.883627909329;4665.04366604852;4682.578567928903;4721.032188401301;4955.82654607087;4958.578520825626;4959.603231741524;4961.7271050092595;4998.950010499849;4472.642188624967;4544.818207271672;4581.083783243298;4675.181843177498;4718.622510199244;4772.475027747015;4792.9281060784815;4796.904061918812;4836.12949669063;4845.563899249085;4859.805607775649;4868.294097355934;4871.244957031666;4871.585915197106;4891.779869905934;4599.862004139881;4723.811047558197;4746.572808447257;4766.45185803637;4786.832460863853;4791.041791641616;4809.182438985451;4811.663183577116;4816.229403295456;4857.101436234308;4733.171694953438;4741.217699079752;4742.027884283782;4743.051389722138;4794.448638406628;4645.674802763774;4756.143894099096;4798.664093513421;4806.8798280043275;4811.759412029314;4715.834945776881;4733.739644319596;4735.384400027974;4743.715377077387;4782.354382158364 10:56:45 INFO - PROCESS | 15936 | |1;ext.html;558.9730758154444;578.8408187748369;580.7676929228309;594.2690490696443;605.3008774865033;27047.864760676195;27589.31026724333;29435;29487.852560737192;39414.60585394145;40214;40412.59587404125;40461.39307910384;40470.59529404705;40482;7724.884126738089;7859.253370929752;7869.331106855895;7871.134175240719;7878;7763.922360776376;7825.843483130334;7833.764987050369;7844.882326765103;7845.568493732842;7829.138794732575;7865.606719664022;7872.173421790715;7878.684852605889;7884.093329267122;7838.412119091063;7842.137364889858;7863.960680196619;7869.921300786976;7878.054633443966;7723.304902558797;7798.571078590675;7802.258785415376;7802.921970780277;7806;37860.62139378626;37919;38074;38141;38399;2814.394905095394;2934.4131173765118;2959.689232630564;2984.3732816108645;3021.138975392025;28834.279143021384;29245.561316580268;29257.853710731524;29483;30182.69817301821;2921.7662586992988;2928.2825707701536;2943.2641839540115;2963.4813907566304;3003.4443627928904;252171;253730;254981;255539;255984;31286.217844554067;52569.211461828105;53077;53131;53173.202401964;31720;33786.324273514394;33832.83083584566;33839.49240761391;33857.83071084629;13340.866591333963;13514.391852366667;13560.321983900765;13573.796393054112;13579.253141077137;11110.277831940897;11181.161412894066;11183.440827958731;11190;11191.216614837045;7823.100343460575;7849.332806711379;7873.212678732081;7914.406419518559;7923.049234091945;3095.860686269123;3126.640436349849;3137.3568418474156;3138.497840345534;3205.182678416989;842.3429724814654;874.5889431966965;882.0722765276769;884.9823003540022;906.9818603628022;27001.729982699922;27300;27651.170464886087;27707.445851082866;27962.580561291597;818.3248819723751;885.8361203177304;911.7811725185908;921.235374639048;964.0215181590692;13844.653883652787;14354.49759258442;14448;14610.780838287434;14686;370913;374132;375292;375789;376225;47348.52651473441;48352.758236208596;48367;48502.27246591304;48561.27158092632;1082.226208261097;1161.9360935148648;1170.5025364220173;1180.7955884997255;1212.593781083347;27522.17433476999;28496.287592810346;28745.42509149847;29274.268143296587;29448.558271625516;40073.79963100166;40573.79713101416;40753.38869916894;40769.1846163081;40837.591624083376;251705;251979;252157;252216;254139;22105.44736381539;23945.16191933274;24533.509329812947;24825.50348992974;25943.87028064923;40610.79694601508;40792.59207407888;41181.1763764717;41627;42095.789521053426;34932.126696831765;35563.28873422569;35810.64189358177;35828.82085589555;36493.45259821158;35695;35717;36032.63967360293;36058.4591231137;36319;34261.82869085639;35073.1231719209;35125.47311790376;35128.29743405169;35279;30651;32218;32330.515042273913;32375.51436728498;32611.34777304488;23688.644670330305;24430.03242703916;24655.260342189762;24772.38069048288;24783.21929960473 10:56:45 INFO - PROCESS | 15936 | |2;jquery.html;354.33208402161915;367.9852805887766;369.68207341686144;371.5021870693271;394.36704089935654;13006.609801705941;16590.25343859526;17255.827441725563;18578.72131918019;18597.721034184466;17453.476395708116;17876.82123178771;17902.910485447555;17915;18273.17770700322;4844.781984810683;5183.092958732225;5188.688678679272;5188.948110518903;5190;3758.7220345082665;5061.721605311706;5781.306243250816;6081.270247570298;6095.451409373156;6063.605865618742;6086.208792856923;6130.478909292716;6131.3562075982045;6131.816045518642;5198.8700282493055;5583.134614134816;5586.776528938817;5639.971800141014;5658.971705141489;5275;5378.354597448292;5474.534664553517;5474.863128421782;5475.5072043516275;12636.620901372973;12734.235945843186;12773;12844.807327890088;13233.801492977613;1763.5943732941496;1784.0366202250768;1852.786929503111;2091.7176181215495;2430.1737409280754;9112;9225.215856652192;9439.197668198143;9736;9755.951220243924;1723.1901006526912;1739.5216315513335;1782.073321872632;1845.372573325076;1853.9073046347628;65579.3442065578;72874;73312.26687733107;74745.25254747437;74868.99999999946;9239.861402078974;9765.853512197322;10352.53413596375;10468.110210632029;10548.630797922036;26889.462210756068;27541.31146721308;28495;29805;29816;8944.105589441004;8979;9221.123993220634;9365.906340936639;9434.764130896645;7550;7735.1491335953;7847.2152784721075;7991.600419978978;8091.352691784643;8232.670693172326;8410.158984101663;8499.280230326236;8538.402311838112;8549.615267312985;3067.8312692801665;3127.8748850045745;3354.9832250839077;3404.4382676858536;3428.3486137633768;774.31859963232;809.1665584448028;826.7395770332446;868.079835374505;893.718478679214;16878.24047917822;17752.644947101246;17773.20020599076;17836.286548538174;18117.90941045313;815.5066184958133;845.3786466946789;867.6225841758855;906.2840356118593;922.8431166701677;9578.425294482353;9947.950260248652;9966.2525310602;9979.201663866874;10140.087392134743;338025;347959;350462;350710;350823;48353.758231208616;50561.74719126381;74299;75311.24688753152;81950.59024704839;907.6051917415813;914.6707185413379;917.7843206846386;942.3262367407336;944.3531181140941;12469.625911222678;15594.532164035098;15756;16428.589285267964;16875.831241687425;36050;36598.8170059148;37884.05289867776;39100;39687.80156099201;52444;54886;56108.43891561032;56409.71795140998;56739;7308.378787803096;7472.887906681295;7505.099388073466;7700.537967721954;7728.343090837342;6655.733770649314;10889.78220435571;11373.20387572895;11570.826437603275;11627.18609697347;9703.272254580794;9931.900680993098;10070.99290070987;10154.796904062025;10543.051125398752;9741.707748767549;9859;9948.900510994798;9989.60041598357;10114.241431892491;5436.211749296409;6467.611943283418;9252.380833354271;10350.844737329096;10507.684769456928;7526.360259378014;7579.431542634435;7600.923990760243;7699.422543309386;7717.459777815499;9503.619855205714;9835;9842.950785246028;9959.950200248952;10091.091801737879 10:56:45 INFO - PROCESS | 15936 | |3;mootools.html;1362.1690768631133;1416.6670832354398;1486.643205630649;1670.6575152093822;1691.7208660571014;7542.849143017143;7958.084820245674;8054.033515978076;8062.072861620923;8063.838723225532;6668.433183179435;7641.656125474353;7872.0947091084545;7886.723964661238;7923.722669706562;2243.6410174372063;2273.4202778291515;2274.8407611467205;2275.3174047785683;2276.260215429992;1868.570228847366;2222.1333679864865;2224.13258829056;2263.241813992306;2269.7616750241236;2005.4384772263716;2071.2750537311895;2078.044099714133;2095.769465358817;2097.727295451597;2150.827933765295;2166.198506552578;2171.0989939175224;2174.4781252499442;2224.354937068248;2186.6610675345187;2193.320070778064;2193.3529608765452;2194.1442837293466;2194.319760874118;8015.879761803578;8144.552049637267;8147.429679922408;8149.7147599833725;8151.959240203821;4517.683762136652;4665.673402861801;4668.883277918046;4674.228752255874;4676.859694209179;2620.4628051249447;2763.2677340504783;2764.7649949754295;2766.0318888389106;2768.9446211075665;770.4760762681375;794.9801254968614;803.333233416263;806.9354451643854;819.2503858969036;10668.253222274367;10702.090322322534;10729.248952573324;10735.302205356627;10735.946320268427;4049.817758200888;4105.220008198433;4229.6827737919775;4277.91444171121;4306.461692288464;9187.127222913812;9224.907750922539;9231.95384023089;9239;9240.445573265626;4592.862214133581;4609.700369475973;4624.560666736655;4630.189716799614;4639.072185562901;4123.731957422758;4132.380142978517;4135.648469880034;4135.855245066408;4157.397177409259;3684.5946945835935;3752.5121734174927;3752.9437058444146;3794.962050379516;3808.0289526171205;1060.3372891942536;1209.618970024457;1211.715246916974;1214;1221.4503473436812;633.7274971762095;718.3032458515232;733.5561984998999;805.6857825447963;861.8276344731079;5035.84892453227;5383.111786555174;5461.098918678374;5587.329520457572;5678.290213723285;853.2534032721369;859.3597769661642;873.6985739919718;888.8666699994923;905.1039470923738;3707.4994875691436;3786.73492855503;3790.431435284674;3819.2170605025904;3859.2474467479133;9634.951825240969;9970.451625160686;10102.949485252526;10112.03935626129;10119.190464762802;8159.388045896581;9923.1069203772;9924.950375248078;9935.354201976848;9937.701868943943;7225.638718064076;7493.925060749323;7518.210587888193;7673.386129109658;7681.155072941972;5638.4925356718095;5744.975018592582;5869.4717475427415;5913.2608423947;5972.044472884491;9245.445273283625;9314.161725444743;9428.811423771349;9433.858492122486;9442.716718498456;8708.129187081242;9147.039560846282;9158.129977652112;9366.625334986524;9511.381760185566;6790.287019862843;7113.964430177816;7117.501774875916;7121.715131394686;7121.786346409616;7654.349380302737;7823.413244006836;7824.100228473799;7826.960865195865;7828.804279893048;6870.965645171742;6996.895046574204;7105.644717764195;7203.351698347174;7213.639318033972;6950;6994.370506654425;7064.894026589708;7175.820604484721;7214.062171917617;6450.741970321134;6529.183852018497;6530.771423000172;6532.706028228646;6534.281229064704;4568.451785785727;4717.599004084691;4734.07685501324;4749.477557468606;4789.808407663654;4803.711777293373;4818.855434336975;4820.638452116175;4847.442544107332;4886.9022619546695 10:56:45 INFO - PROCESS | 15936 | |4;prototype.html;297.5358440832302;302.70788688915195;308.20329448375946;308.92276930767304;312.88579668421033;4549.749763762991;4746.406699162605;4749.121412538683;4788.545088216622;4802.111609352268;4573.725576465406;4694.427366832116;4698.9060218795685;4783.258594917785;4793.712377257367;3774.414965680324;3779.130799916021;3791.8862434127022;3800.90497737556;3831.8658846940434;3577.749557530974;3617.4935509028755;3778.7732736035787;3779.4708740776314;3800.524934383202;3671.7246206534483;3718.2005868738215;3744.9625503745024;3747.9250414991684;3765.077555998784;3729.0863738384;3738.719596030295;3740.663340299386;3742.6818720408796;3755.4179102239195;3316.8507417166284;3319.3029463812627;3319.9834000830083;3320.8505617247283;3329.067860998924;4513.977430112861;4612.746298953556;4621.930671039937;4652.116097941414;4707.693999889996;4253.744775313491;4275.337322714984;4277.165952639206;4295.871123866258;4296.548862369469;4919.2129259318335;4922.729249891255;4925.729084900329;4940.678855874393;4984.37695288089;3373.949390759116;3590.6409359064146;3632.745707800455;3653.0867283179205;3657.3051120287328;5126.820561280375;5144.6913185209005;5154.561862241677;5168.250603662485;5172.7155006475;3621.5654121505586;3621.927561448809;3641.8361173747244;3646.288973650113;3651.908702282411;3720.311742327678;3727.459518369821;3729.179580492287;3730.7201959852578;3743.1016556026357;4002.839886404511;4195.265828480004;4205;4220.366944958281;4258.871399079247;4986.401631804207;4992.625553083533;5002.474740152305;5025.572826309804;5060.038592667382;1184.7215904262491;1236.4930378544934;1258.653870185688;1269.1560112525067;1276.342683517989;852.1138016462933;858.7981824271292;872.7818045488627;873.7160422862595;882.179572997106;4384.517703052662;4388.648908087345;4394.099209662011;4397.780110994438;4400.44994375703;5083.38999320084;5131.846044618667;5132.820351287687;5153.845384638467;5160.690358578498;4368.7815609219415;4373.606375426163;4399.5160532341415;4402;4407.933880991788;2359.2686267257204;2427.684401027855;2446.865422401785;2449.6815413996064;2472.6291056341333;4320.524742278347;4327.307630779061;4336.674749393808;4339.327404252346;4372.846950356722;4582.037772067836;4591.839285625054;4639.884002899887;4655.348251244828;4660.207764680013;4130.987907962508;4272.893177670521;4301.720388174758;4317.84887528935;4338.956610433918;4523.864284071483;4550.111703642951;4565.931511027404;4567.06375193078;4571.245744452128;4469.530699276529;4493.517139343943;4500.144972455223;4503.234450143549;4565.7488838112895;4139.730917490354;4270.594293542109;4292.720973136736;4300.591443812833;4326.956730432656;3310.6095439915775;3333.533305337206;3341.849616767203;3356.9328613428083;3366.848491817923;4540.682152249311;4545.6136228420955;4560.3843481129625;4597.816087356468;4896.751328411232;4726.97636511829;4951.183054795918;4975.726335051462;4991.376077990251;5015.64890457679;4942.481039490802;4943.8516844494725;4960.330355401975;4980.427250866197;4999.175136102503;4705.64707646921;4912.901741965212;4913.1893237615395;4927.310176575211;4946.62900282473;4989.401271847401;4990.451050384382;4994.850154495371;5008.6744361616375;5014.272930424995;4885.731284779371;4894.559489645949;4900.632452566;4936.284238785284;4945.77744001528 10:56:45 INFO - PROCESS | 15936 | |5;yui.html;625.4496043481737;634.3371177119909;644.5037321262625;728.6903066196865;756.8070142113762;12065.034797216224;12949.287789171593;13001.609951701465;13060.73878522429;13069.08516403851;11718.707032324175;13279.26964016981;13372.933135334333;13417.329133543333;13501.932490337535;776.0609662308599;794.4915254237293;797.788586024701;798.9960050199741;799.9600019999006;781.5662307419379;783.7648705388389;783.8549868274388;784.7802615267734;785.1716439156687;838.8322335532887;839.6725277141919;839.6935118681698;841.0706169682504;842.4692443760453;829.7054545636272;829.9377546683993;830.4187069051688;830.6303694855792;830.8172202115585;612.2102487790745;612.9478994285491;613.0344707086313;613.1630324606924;614.5206738743786;12511.624651260478;12679.049071319596;12685.365731713377;12698.365081745877;12699.428525716365;10330.690079297634;10439.686809395731;10530.15758739299;10605.151587873028;10792.730181745519;9413.48225847578;9454.763630909283;9615.51922403877;9668;9793.363431376938;3127.7654175936896;3175.3490534440384;3177.3327601203546;3180.936381272362;3202.679732026802;53594.73202634001;60387.698061509414;61242;61856;62274.37725622731;9759.072888075621;9834.704958851104;10385.896141038493;10498.790024199474;10562.577496900038;17878.463646090637;17880.821191787916;17880.821191787916;17889.910550447425;17899.73150402745;6766.28953959837;6959;6975.651217439107;7050.048243487064;7158.60627665473;3591.4612808078473;3663.358912190356;3683.0478756599678;3706.4440333950124;3717.0893131182493;2759.0343379816904;2875.051233093074;2878.064628995585;2880.683124856264;2883.178294186147;486.41144215498934;491.13314999026744;502.29427654145985;502.9069622119919;503.1597232621531;485.18488938583516;507.11508417811154;512.9589632829365;519.6232731269874;524.8189374665734;7107.75122870697;7530.43521735861;7595.810104747315;7621.542707437571;7621.733239336597;399.0980384331374;452.2560388161456;464.31565527539084;477.6608607888369;498.9920360871093;3462.7056700180765;3562.305350456636;3677.9448308275396;3684.097396137963;3732.1789206374556;53002.734986324824;53145.202821957704;54246.45753542493;72186;75277;75655.62172189103;78102.6094869522;79633.60183199047;79674.20325796668;80679.59660201661;43460.78269608632;44261;66095;69661.3033869665;70830;7758.3017528422715;7782.027246594176;7821.178776228641;7918.1610205896895;8021.799455013671;43257;43706.34440483459;44333.33499997438;44348;44501.777491112334;52810.471895280556;53866.73066634642;53966.73016634892;54035;57156.85637289989;9469.47917864524;9772.706818795448;9822.5088745561;10121.848172277569;10226.6420675276;11184.776304473702;11379.658610241706;11833.881661183623;12011.399430028288;12613.558525451564;10856.891431085589;11015.614453494089;11430.657080287605;11818.231814932002;12439.875601244234;10756.731081723019;10854.837177442503;11300.717482062686;11333.659990200307;11334.093272538343;11598.47806848677;11622.6513204604;11691.824622630838;12239.816402754144;12318.876811232132;9488.430694158373;9862.457564834003;10374.221933354878;10386.948065259625;10399.84400233982;9478.289128315542;9516.19112375456;9524.666636667684;9669.226461883172;9845.212383009486 10:56:45 INFO - PROCESS | 15936 | __end_tp_report 10:56:45 INFO - PROCESS | 15936 | __start_cc_report 10:56:45 INFO - PROCESS | 15936 | _x_x_mozilla_cycle_collect,1014 10:56:45 INFO - PROCESS | 15936 | __end_cc_report 10:56:45 INFO - PROCESS | 15936 | __startTimestamp1468432605521__endTimestamp 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | ------- Summary: start ------- 10:56:45 INFO - PROCESS | 15936 | Number of tests: 6 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#0] dojo.html Cycles:165 Average:4541.27 Median:4675.18 stddev:474.34 (10.1%) stddev-sans-first:449.99 10:56:45 INFO - PROCESS | 15936 | Values: 2574.3 2580.7 2614.2 2616.5 2624.3 4468.1 4499.5 4577.2 4604.4 4607.9 4576.6 4579.4 4603.8 4617.0 4625.5 3927.5 4116.1 4158.0 4183.5 4329.9 4237.4 4297.1 4298.5 4311.7 4339.8 4117.2 4154.5 4170.4 4173.8 4213.9 4239.6 4241.3 4252.9 4263.0 4270.2 4244.2 4282.3 4293.9 4320.5 4333.9 4407.8 4531.6 4586.5 4603.0 4696.7 4910.4 4916.6 4916.9 4947.5 4949.9 4914.5 4938.1 4966.3 4977.8 4990.4 4457.9 4574.0 4593.2 4618.1 4671.8 5095.4 5110.3 5115.3 5120.6 5128.8 4700.7 4904.7 4918.6 4924.2 4926.0 4851.6 4890.4 4904.9 4926.8 4932.7 4856.7 4878.8 4890.0 4891.8 4937.8 4707.6 4811.1 4874.9 4878.7 4938.5 4140.6 4167.7 4170.4 4195.4 4208.2 3639.0 3652.7 3670.0 3695.5 3714.9 4087.0 4125.5 4126.4 4230.6 4237.0 4878.5 4939.9 4944.0 4953.9 4954.1 4214.9 4242.4 4244.6 4278.7 4286.9 4240.6 4368.7 4419.5 4424.3 4430.8 4650.3 4654.9 4665.0 4682.6 4721.0 4955.8 4958.6 4959.6 4961.7 4999.0 4472.6 4544.8 4581.1 4675.2 4718.6 4772.5 4792.9 4796.9 4836.1 4845.6 4859.8 4868.3 4871.2 4871.6 4891.8 4599.9 4723.8 4746.6 4766.5 4786.8 4791.0 4809.2 4811.7 4816.2 4857.1 4733.2 4741.2 4742.0 4743.1 4794.4 4645.7 4756.1 4798.7 4806.9 4811.8 4715.8 4733.7 4735.4 4743.7 4782.4 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#1] ext.html Cycles:180 Average:43732.23 Median:35421.14 stddev:78838.54 (222.6%) stddev-sans-first:78993.07 10:56:45 INFO - PROCESS | 15936 | Values: 559.0 578.8 580.8 594.3 605.3 27047.9 27589.3 29435.0 29487.9 39414.6 40214.0 40412.6 40461.4 40470.6 40482.0 7724.9 7859.3 7869.3 7871.1 7878.0 7763.9 7825.8 7833.8 7844.9 7845.6 7829.1 7865.6 7872.2 7878.7 7884.1 7838.4 7842.1 7864.0 7869.9 7878.1 7723.3 7798.6 7802.3 7802.9 7806.0 37860.6 37919.0 38074.0 38141.0 38399.0 2814.4 2934.4 2959.7 2984.4 3021.1 28834.3 29245.6 29257.9 29483.0 30182.7 2921.8 2928.3 2943.3 2963.5 3003.4 252171.0 253730.0 254981.0 255539.0 255984.0 31286.2 52569.2 53077.0 53131.0 53173.2 31720.0 33786.3 33832.8 33839.5 33857.8 13340.9 13514.4 13560.3 13573.8 13579.3 11110.3 11181.2 11183.4 11190.0 11191.2 7823.1 7849.3 7873.2 7914.4 7923.0 3095.9 3126.6 3137.4 3138.5 3205.2 842.3 874.6 882.1 885.0 907.0 27001.7 27300.0 27651.2 27707.4 27962.6 818.3 885.8 911.8 921.2 964.0 13844.7 14354.5 14448.0 14610.8 14686.0 370913.0 374132.0 375292.0 375789.0 376225.0 47348.5 48352.8 48367.0 48502.3 48561.3 1082.2 1161.9 1170.5 1180.8 1212.6 27522.2 28496.3 28745.4 29274.3 29448.6 40073.8 40573.8 40753.4 40769.2 40837.6 251705.0 251979.0 252157.0 252216.0 254139.0 22105.4 23945.2 24533.5 24825.5 25943.9 40610.8 40792.6 41181.2 41627.0 42095.8 34932.1 35563.3 35810.6 35828.8 36493.5 35695.0 35717.0 36032.6 36058.5 36319.0 34261.8 35073.1 35125.5 35128.3 35279.0 30651.0 32218.0 32330.5 32375.5 32611.3 23688.6 24430.0 24655.3 24772.4 24783.2 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#2] jquery.html Cycles:180 Average:23462.66 Median:5475.19 stddev:57591.76 (1051.9%) stddev-sans-first:57727.18 10:56:45 INFO - PROCESS | 15936 | Values: 354.3 368.0 369.7 371.5 394.4 13006.6 16590.3 17255.8 18578.7 18597.7 17453.5 17876.8 17902.9 17915.0 18273.2 4844.8 5183.1 5188.7 5188.9 5190.0 3758.7 5061.7 5781.3 6081.3 6095.5 6063.6 6086.2 6130.5 6131.4 6131.8 5198.9 5583.1 5586.8 5640.0 5659.0 5275.0 5378.4 5474.5 5474.9 5475.5 12636.6 12734.2 12773.0 12844.8 13233.8 1763.6 1784.0 1852.8 2091.7 2430.2 9112.0 9225.2 9439.2 9736.0 9756.0 1723.2 1739.5 1782.1 1845.4 1853.9 65579.3 72874.0 73312.3 74745.3 74869.0 9239.9 9765.9 10352.5 10468.1 10548.6 26889.5 27541.3 28495.0 29805.0 29816.0 8944.1 8979.0 9221.1 9365.9 9434.8 7550.0 7735.1 7847.2 7991.6 8091.4 8232.7 8410.2 8499.3 8538.4 8549.6 3067.8 3127.9 3355.0 3404.4 3428.3 774.3 809.2 826.7 868.1 893.7 16878.2 17752.6 17773.2 17836.3 18117.9 815.5 845.4 867.6 906.3 922.8 9578.4 9948.0 9966.3 9979.2 10140.1 338025.0 347959.0 350462.0 350710.0 350823.0 48353.8 50561.7 74299.0 75311.2 81950.6 907.6 914.7 917.8 942.3 944.4 12469.6 15594.5 15756.0 16428.6 16875.8 36050.0 36598.8 37884.1 39100.0 39687.8 52444.0 54886.0 56108.4 56409.7 56739.0 7308.4 7472.9 7505.1 7700.5 7728.3 6655.7 10889.8 11373.2 11570.8 11627.2 9703.3 9931.9 10071.0 10154.8 10543.1 9741.7 9859.0 9948.9 9989.6 10114.2 5436.2 6467.6 9252.4 10350.8 10507.7 7526.4 7579.4 7600.9 7699.4 7717.5 9503.6 9835.0 9843.0 9960.0 10091.1 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#3] mootools.html Cycles:180 Average:5262.29 Median:5524.21 stddev:2970.86 (53.8%) stddev-sans-first:2964.74 10:56:45 INFO - PROCESS | 15936 | Values: 1362.2 1416.7 1486.6 1670.7 1691.7 7542.8 7958.1 8054.0 8062.1 8063.8 6668.4 7641.7 7872.1 7886.7 7923.7 2243.6 2273.4 2274.8 2275.3 2276.3 1868.6 2222.1 2224.1 2263.2 2269.8 2005.4 2071.3 2078.0 2095.8 2097.7 2150.8 2166.2 2171.1 2174.5 2224.4 2186.7 2193.3 2193.4 2194.1 2194.3 8015.9 8144.6 8147.4 8149.7 8152.0 4517.7 4665.7 4668.9 4674.2 4676.9 2620.5 2763.3 2764.8 2766.0 2768.9 770.5 795.0 803.3 806.9 819.3 10668.3 10702.1 10729.2 10735.3 10735.9 4049.8 4105.2 4229.7 4277.9 4306.5 9187.1 9224.9 9232.0 9239.0 9240.4 4592.9 4609.7 4624.6 4630.2 4639.1 4123.7 4132.4 4135.6 4135.9 4157.4 3684.6 3752.5 3752.9 3795.0 3808.0 1060.3 1209.6 1211.7 1214.0 1221.5 633.7 718.3 733.6 805.7 861.8 5035.8 5383.1 5461.1 5587.3 5678.3 853.3 859.4 873.7 888.9 905.1 3707.5 3786.7 3790.4 3819.2 3859.2 9635.0 9970.5 10102.9 10112.0 10119.2 8159.4 9923.1 9925.0 9935.4 9937.7 7225.6 7493.9 7518.2 7673.4 7681.2 5638.5 5745.0 5869.5 5913.3 5972.0 9245.4 9314.2 9428.8 9433.9 9442.7 8708.1 9147.0 9158.1 9366.6 9511.4 6790.3 7114.0 7117.5 7121.7 7121.8 7654.3 7823.4 7824.1 7827.0 7828.8 6871.0 6996.9 7105.6 7203.4 7213.6 6950.0 6994.4 7064.9 7175.8 7214.1 6450.7 6529.2 6530.8 6532.7 6534.3 4568.5 4717.6 4734.1 4749.5 4789.8 4803.7 4818.9 4820.6 4847.4 4886.9 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#4] prototype.html Cycles:180 Average:4023.87 Median:4398.65 stddev:1151.94 (26.2%) stddev-sans-first:1120.70 10:56:45 INFO - PROCESS | 15936 | Values: 297.5 302.7 308.2 308.9 312.9 4549.7 4746.4 4749.1 4788.5 4802.1 4573.7 4694.4 4698.9 4783.3 4793.7 3774.4 3779.1 3791.9 3800.9 3831.9 3577.7 3617.5 3778.8 3779.5 3800.5 3671.7 3718.2 3745.0 3747.9 3765.1 3729.1 3738.7 3740.7 3742.7 3755.4 3316.9 3319.3 3320.0 3320.9 3329.1 4514.0 4612.7 4621.9 4652.1 4707.7 4253.7 4275.3 4277.2 4295.9 4296.5 4919.2 4922.7 4925.7 4940.7 4984.4 3373.9 3590.6 3632.7 3653.1 3657.3 5126.8 5144.7 5154.6 5168.3 5172.7 3621.6 3621.9 3641.8 3646.3 3651.9 3720.3 3727.5 3729.2 3730.7 3743.1 4002.8 4195.3 4205.0 4220.4 4258.9 4986.4 4992.6 5002.5 5025.6 5060.0 1184.7 1236.5 1258.7 1269.2 1276.3 852.1 858.8 872.8 873.7 882.2 4384.5 4388.6 4394.1 4397.8 4400.4 5083.4 5131.8 5132.8 5153.8 5160.7 4368.8 4373.6 4399.5 4402.0 4407.9 2359.3 2427.7 2446.9 2449.7 2472.6 4320.5 4327.3 4336.7 4339.3 4372.8 4582.0 4591.8 4639.9 4655.3 4660.2 4131.0 4272.9 4301.7 4317.8 4339.0 4523.9 4550.1 4565.9 4567.1 4571.2 4469.5 4493.5 4500.1 4503.2 4565.7 4139.7 4270.6 4292.7 4300.6 4327.0 3310.6 3333.5 3341.8 3356.9 3366.8 4540.7 4545.6 4560.4 4597.8 4896.8 4727.0 4951.2 4975.7 4991.4 5015.6 4942.5 4943.9 4960.3 4980.4 4999.2 4705.6 4912.9 4913.2 4927.3 4946.6 4989.4 4990.5 4994.9 5008.7 5014.3 4885.7 4894.6 4900.6 4936.3 4945.8 10:56:45 INFO - PROCESS | 15936 | 10:56:45 INFO - PROCESS | 15936 | [#5] yui.html Cycles:180 Average:15605.55 Median:505.14 stddev:20878.52 (4133.2%) stddev-sans-first:20906.79 10:56:45 INFO - PROCESS | 15936 | Values: 625.4 634.3 644.5 728.7 756.8 12065.0 12949.3 13001.6 13060.7 13069.1 11718.7 13279.3 13372.9 13417.3 13501.9 776.1 794.5 797.8 799.0 800.0 781.6 783.8 783.9 784.8 785.2 838.8 839.7 839.7 841.1 842.5 829.7 829.9 830.4 830.6 830.8 612.2 612.9 613.0 613.2 614.5 12511.6 12679.0 12685.4 12698.4 12699.4 10330.7 10439.7 10530.2 10605.2 10792.7 9413.5 9454.8 9615.5 9668.0 9793.4 3127.8 3175.3 3177.3 3180.9 3202.7 53594.7 60387.7 61242.0 61856.0 62274.4 9759.1 9834.7 10385.9 10498.8 10562.6 17878.5 17880.8 17880.8 17889.9 17899.7 6766.3 6959.0 6975.7 7050.0 7158.6 3591.5 3663.4 3683.0 3706.4 3717.1 2759.0 2875.1 2878.1 2880.7 2883.2 486.4 491.1 502.3 502.9 503.2 485.2 507.1 513.0 519.6 524.8 7107.8 7530.4 7595.8 7621.5 7621.7 399.1 452.3 464.3 477.7 499.0 3462.7 3562.3 3677.9 3684.1 3732.2 53002.7 53145.2 54246.5 72186.0 75277.0 75655.6 78102.6 79633.6 79674.2 80679.6 43460.8 44261.0 66095.0 69661.3 70830.0 7758.3 7782.0 7821.2 7918.2 8021.8 43257.0 43706.3 44333.3 44348.0 44501.8 52810.5 53866.7 53966.7 54035.0 57156.9 9469.5 9772.7 9822.5 10121.8 10226.6 11184.8 11379.7 11833.9 12011.4 12613.6 10856.9 11015.6 11430.7 11818.2 12439.9 10756.7 10854.8 11300.7 11333.7 11334.1 11598.5 11622.7 11691.8 12239.8 12318.9 9488.4 9862.5 10374.2 10386.9 10399.8 9478.3 9516.2 9524.7 9669.2 9845.2 10:56:45 INFO - PROCESS | 15936 | -------- Summary: end -------- 10:56:45 INFO - PROCESS | 15936 | 10:56:46 INFO - TEST-INFO | 15936: exit 0 10:56:46 INFO - TEST-OK | dromaeo_css | took 1118449ms 10:56:46 INFO - TEST-START | kraken 10:56:46 INFO - operating with platform_type : linux_ 10:56:46 INFO - Initialising browser for kraken test... 10:56:46 INFO - TEST-INFO | started process 16123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsXMT0/profile http://localhost:54730/getInfo.html) 10:56:50 INFO - PROCESS | 16123 | __metrics Screen width/height:1600/1200 10:56:50 INFO - PROCESS | 16123 | colorDepth:24 10:56:50 INFO - PROCESS | 16123 | Browser inner width/height: 1024/697 10:56:50 INFO - PROCESS | 16123 | __metrics 10:56:51 INFO - PROCESS | 16123 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:56:51 INFO - PROCESS | 16123 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:52 INFO - TEST-INFO | 16123: exit 0 10:56:52 INFO - Browser initialized. 10:56:52 INFO - Running cycle 1/1 for kraken test... 10:56:52 INFO - TEST-INFO | started process 16204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsXMT0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:04 INFO - PROCESS | 16204 | RSS: Main: 159608832 10:57:04 INFO - PROCESS | 16204 | 10:57:06 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54730/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:07 INFO - PROCESS | 16204 | RSS: Main: 217239552 10:57:07 INFO - PROCESS | 16204 | 10:57:10 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54730/tests/kraken/driver.html?testName=audio-dft) 10:57:11 INFO - PROCESS | 16204 | RSS: Main: 204517376 10:57:11 INFO - PROCESS | 16204 | 10:57:14 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54730/tests/kraken/driver.html?testName=audio-fft) 10:57:14 INFO - PROCESS | 16204 | RSS: Main: 271646720 10:57:14 INFO - PROCESS | 16204 | 10:57:17 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54730/tests/kraken/driver.html?testName=audio-oscillator) 10:57:17 INFO - PROCESS | 16204 | RSS: Main: 181747712 10:57:17 INFO - PROCESS | 16204 | 10:57:19 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:20 INFO - PROCESS | 16204 | RSS: Main: 185946112 10:57:20 INFO - PROCESS | 16204 | 10:57:23 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54730/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:24 INFO - PROCESS | 16204 | RSS: Main: 222224384 10:57:24 INFO - PROCESS | 16204 | 10:57:27 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54730/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:28 INFO - PROCESS | 16204 | RSS: Main: 217587712 10:57:28 INFO - PROCESS | 16204 | 10:57:31 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54730/tests/kraken/driver.html?testName=json-parse-financial) 10:57:31 INFO - PROCESS | 16204 | RSS: Main: 220770304 10:57:31 INFO - PROCESS | 16204 | 10:57:33 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:57:34 INFO - PROCESS | 16204 | RSS: Main: 206974976 10:57:34 INFO - PROCESS | 16204 | 10:57:35 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:57:36 INFO - PROCESS | 16204 | RSS: Main: 213106688 10:57:36 INFO - PROCESS | 16204 | 10:57:38 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:39 INFO - PROCESS | 16204 | RSS: Main: 208785408 10:57:39 INFO - PROCESS | 16204 | 10:57:42 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:42 INFO - PROCESS | 16204 | RSS: Main: 223444992 10:57:42 INFO - PROCESS | 16204 | 10:57:45 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:46 INFO - PROCESS | 16204 | RSS: Main: 224370688 10:57:46 INFO - PROCESS | 16204 | 10:57:47 INFO - PROCESS | 16204 | Cycle 1(1): loaded http://localhost:54730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54730/tests/kraken/driver.html?testName=ai-astar) 10:57:48 INFO - PROCESS | 16204 | RSS: Main: 266158080 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | __start_tp_report 10:57:48 INFO - PROCESS | 16204 | _x_x_mozilla_page_load 10:57:48 INFO - PROCESS | 16204 | _x_x_mozilla_page_load_details 10:57:48 INFO - PROCESS | 16204 | |i|pagename|runs| 10:57:48 INFO - PROCESS | 16204 | |0;ai-astar;104;114;113;114;114;114;113;113;115;113 10:57:48 INFO - PROCESS | 16204 | |1;audio-beat-detection;152;127;123;175;123;122;151;122;166;123 10:57:48 INFO - PROCESS | 16204 | |2;audio-dft;162;162;160;160;161;161;161;161;161;162 10:57:48 INFO - PROCESS | 16204 | |3;audio-fft;75;82;76;118;76;77;74;74;102;76 10:57:48 INFO - PROCESS | 16204 | |4;audio-oscillator;86;86;114;85;85;86;121;85;84;128 10:57:48 INFO - PROCESS | 16204 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;117;117;117 10:57:48 INFO - PROCESS | 16204 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 10:57:48 INFO - PROCESS | 16204 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 10:57:48 INFO - PROCESS | 16204 | |8;json-parse-financial;65;63;63;65;63;64;65;63;64;63 10:57:48 INFO - PROCESS | 16204 | |9;json-stringify-tinderbox;66;66;65;65;66;66;64;66;66;65 10:57:48 INFO - PROCESS | 16204 | |10;stanford-crypto-aes;79;82;81;79;78;81;80;79;77;77 10:57:48 INFO - PROCESS | 16204 | |11;stanford-crypto-ccm;126;134;129;132;133;136;129;135;168;129 10:57:48 INFO - PROCESS | 16204 | |12;stanford-crypto-pbkdf2;163;166;167;167;167;166;166;170;165;165 10:57:48 INFO - PROCESS | 16204 | |13;stanford-crypto-sha256-iterative;67;66;66;66;65;65;69;66;64;65 10:57:48 INFO - PROCESS | 16204 | __end_tp_report 10:57:48 INFO - PROCESS | 16204 | __start_cc_report 10:57:48 INFO - PROCESS | 16204 | _x_x_mozilla_cycle_collect,1909 10:57:48 INFO - PROCESS | 16204 | __end_cc_report 10:57:48 INFO - PROCESS | 16204 | __startTimestamp1468432668160__endTimestamp 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | ------- Summary: start ------- 10:57:48 INFO - PROCESS | 16204 | Number of tests: 14 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:0.71 10:57:48 INFO - PROCESS | 16204 | Values: 104.0 114.0 113.0 114.0 114.0 114.0 113.0 113.0 115.0 113.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:139.00 stddev:20.61 (14.8%) stddev-sans-first:21.27 10:57:48 INFO - PROCESS | 16204 | Values: 152.0 127.0 123.0 175.0 123.0 122.0 151.0 122.0 166.0 123.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:57:48 INFO - PROCESS | 16204 | Values: 162.0 162.0 160.0 160.0 161.0 161.0 161.0 161.0 161.0 162.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.89 (19.6%) stddev-sans-first:15.51 10:57:48 INFO - PROCESS | 16204 | Values: 75.0 82.0 76.0 118.0 76.0 77.0 74.0 74.0 102.0 76.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.58 (20.7%) stddev-sans-first:18.27 10:57:48 INFO - PROCESS | 16204 | Values: 86.0 86.0 114.0 85.0 85.0 86.0 121.0 85.0 84.0 128.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:57:48 INFO - PROCESS | 16204 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 10:57:48 INFO - PROCESS | 16204 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:57:48 INFO - PROCESS | 16204 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 10:57:48 INFO - PROCESS | 16204 | Values: 65.0 63.0 63.0 65.0 63.0 64.0 65.0 63.0 64.0 63.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 10:57:48 INFO - PROCESS | 16204 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 64.0 66.0 66.0 65.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.50 stddev:1.70 (2.1%) stddev-sans-first:1.80 10:57:48 INFO - PROCESS | 16204 | Values: 79.0 82.0 81.0 79.0 78.0 81.0 80.0 79.0 77.0 77.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:133.50 stddev:11.99 (9.0%) stddev-sans-first:12.25 10:57:48 INFO - PROCESS | 16204 | Values: 126.0 134.0 129.0 132.0 133.0 136.0 129.0 135.0 168.0 129.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:1.81 (1.1%) stddev-sans-first:1.51 10:57:48 INFO - PROCESS | 16204 | Values: 163.0 166.0 167.0 167.0 167.0 166.0 166.0 170.0 165.0 165.0 10:57:48 INFO - PROCESS | 16204 | 10:57:48 INFO - PROCESS | 16204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.39 10:57:48 INFO - PROCESS | 16204 | Values: 67.0 66.0 66.0 66.0 65.0 65.0 69.0 66.0 64.0 65.0 10:57:48 INFO - PROCESS | 16204 | -------- Summary: end -------- 10:57:48 INFO - PROCESS | 16204 | 10:57:49 INFO - TEST-INFO | 16204: exit 0 10:57:49 INFO - TEST-OK | kraken | took 62891ms 10:57:49 INFO - SUITE-END | took 1181s 10:57:49 INFO - Completed test suite (00:19:41) 10:57:49 INFO - javascript benchmark 10:57:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.317805781467, 2580.7290234525376, 2614.228802503262, 2616.5159445502572, 2624.291441310846, 4468.128714900596, 4499.505054444016, 4577.244754615489, 4604.44746630404, 4607.884802879929, 4576.588107070363, 4579.38178345924, 4603.7928293226805, 4616.953830461694, 4625.4680711718165, 3927.4894263745673, 4116.053307739229, 4157.958420415803, 4183.456150700405, 4329.891752706192, 4237.427947227131, 4297.1405718856195, 4298.548652391501, 4311.676624253178, 4339.761313127777, 4117.2177286315655, 4154.50145982481, 4170.416141740159, 4173.833046678129, 4213.873583792491, 4239.554846741079, 4241.257779888538, 4252.893677658052, 4262.9786851065855, 4270.210011147948, 4244.236037513247, 4282.314829627276, 4293.8711838644895, 4320.503142138663, 4333.891652708676, 4407.779611019436, 4531.56950089741, 4586.518415566351, 4602.953970460319, 4696.741679207642, 4910.435299940516, 4916.606671466274, 4916.8770780730765, 4947.455779864212, 4949.851504454872, 4914.508549145093, 4938.1111399947995, 4966.304717339575, 4977.776000080005, 4990.3762029746285, 4457.866264012085, 4573.954260457419, 4593.19619066662, 4618.145643055978, 4671.789769460314, 5095.414027386824, 5110.310108135429, 5115.283860259567, 5120.641555091108, 5128.8461346159675, 4700.670953033255, 4904.681195722266, 4918.5573298403315, 4924.162892308316, 4926.039422312686, 4851.587615052689, 4890.364252647133, 4904.901901961941, 4926.802927882916, 4932.704037757746, 4856.660033797671, 4878.802992518703, 4890.0, 4891.779869905863, 4937.753112344369, 4707.576318131316, 4811.08589368019, 4874.878128046827, 4878.658493905393, 4938.530839570235, 4140.627343539096, 4167.749935003849, 4170.395292682605, 4195.391668208093, 4208.22147902639, 3638.9636103639154, 3652.6712595866497, 3670.0457880951144, 3695.519582454264, 3714.851405943786, 4087.0, 4125.463689720377, 4126.401671757639, 4230.64039556635, 4237.046664500463, 4878.487758785276, 4939.901201976012, 4943.950560494421, 4953.851384458472, 4954.108260513142, 4214.873553793391, 4242.363645453207, 4244.554321796167, 4278.743275403485, 4286.89282767927, 4240.639545638655, 4368.716033457878, 4419.535948725402, 4424.336349547593, 4430.778461076933, 4650.255959046536, 4654.883627909329, 4665.04366604852, 4682.578567928903, 4721.032188401301, 4955.82654607087, 4958.578520825626, 4959.603231741524, 4961.7271050092595, 4998.950010499849, 4472.642188624967, 4544.818207271672, 4581.083783243298, 4675.181843177498, 4718.622510199244, 4772.475027747015, 4792.9281060784815, 4796.904061918812, 4836.12949669063, 4845.563899249085, 4859.805607775649, 4868.294097355934, 4871.244957031666, 4871.585915197106, 4891.779869905934, 4599.862004139881, 4723.811047558197, 4746.572808447257, 4766.45185803637, 4786.832460863853, 4791.041791641616, 4809.182438985451, 4811.663183577116, 4816.229403295456, 4857.101436234308, 4733.171694953438, 4741.217699079752, 4742.027884283782, 4743.051389722138, 4794.448638406628, 4645.674802763774, 4756.143894099096, 4798.664093513421, 4806.8798280043275, 4811.759412029314, 4715.834945776881, 4733.739644319596, 4735.384400027974, 4743.715377077387, 4782.354382158364], "value": 4511.511077914911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9730758154444, 578.8408187748369, 580.7676929228309, 594.2690490696443, 605.3008774865033, 27047.864760676195, 27589.31026724333, 29435.0, 29487.852560737192, 39414.60585394145, 40214.0, 40412.59587404125, 40461.39307910384, 40470.59529404705, 40482.0, 7724.884126738089, 7859.253370929752, 7869.331106855895, 7871.134175240719, 7878.0, 7763.922360776376, 7825.843483130334, 7833.764987050369, 7844.882326765103, 7845.568493732842, 7829.138794732575, 7865.606719664022, 7872.173421790715, 7878.684852605889, 7884.093329267122, 7838.412119091063, 7842.137364889858, 7863.960680196619, 7869.921300786976, 7878.054633443966, 7723.304902558797, 7798.571078590675, 7802.258785415376, 7802.921970780277, 7806.0, 37860.62139378626, 37919.0, 38074.0, 38141.0, 38399.0, 2814.394905095394, 2934.4131173765118, 2959.689232630564, 2984.3732816108645, 3021.138975392025, 28834.279143021384, 29245.561316580268, 29257.853710731524, 29483.0, 30182.69817301821, 2921.7662586992988, 2928.2825707701536, 2943.2641839540115, 2963.4813907566304, 3003.4443627928904, 252171.0, 253730.0, 254981.0, 255539.0, 255984.0, 31286.217844554067, 52569.211461828105, 53077.0, 53131.0, 53173.202401964, 31720.0, 33786.324273514394, 33832.83083584566, 33839.49240761391, 33857.83071084629, 13340.866591333963, 13514.391852366667, 13560.321983900765, 13573.796393054112, 13579.253141077137, 11110.277831940897, 11181.161412894066, 11183.440827958731, 11190.0, 11191.216614837045, 7823.100343460575, 7849.332806711379, 7873.212678732081, 7914.406419518559, 7923.049234091945, 3095.860686269123, 3126.640436349849, 3137.3568418474156, 3138.497840345534, 3205.182678416989, 842.3429724814654, 874.5889431966965, 882.0722765276769, 884.9823003540022, 906.9818603628022, 27001.729982699922, 27300.0, 27651.170464886087, 27707.445851082866, 27962.580561291597, 818.3248819723751, 885.8361203177304, 911.7811725185908, 921.235374639048, 964.0215181590692, 13844.653883652787, 14354.49759258442, 14448.0, 14610.780838287434, 14686.0, 370913.0, 374132.0, 375292.0, 375789.0, 376225.0, 47348.52651473441, 48352.758236208596, 48367.0, 48502.27246591304, 48561.27158092632, 1082.226208261097, 1161.9360935148648, 1170.5025364220173, 1180.7955884997255, 1212.593781083347, 27522.17433476999, 28496.287592810346, 28745.42509149847, 29274.268143296587, 29448.558271625516, 40073.79963100166, 40573.79713101416, 40753.38869916894, 40769.1846163081, 40837.591624083376, 251705.0, 251979.0, 252157.0, 252216.0, 254139.0, 22105.44736381539, 23945.16191933274, 24533.509329812947, 24825.50348992974, 25943.87028064923, 40610.79694601508, 40792.59207407888, 41181.1763764717, 41627.0, 42095.789521053426, 34932.126696831765, 35563.28873422569, 35810.64189358177, 35828.82085589555, 36493.45259821158, 35695.0, 35717.0, 36032.63967360293, 36058.4591231137, 36319.0, 34261.82869085639, 35073.1231719209, 35125.47311790376, 35128.29743405169, 35279.0, 30651.0, 32218.0, 32330.515042273913, 32375.51436728498, 32611.34777304488, 23688.644670330305, 24430.03242703916, 24655.260342189762, 24772.38069048288, 24783.21929960473], "value": 15992.271212688695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.33208402161915, 367.9852805887766, 369.68207341686144, 371.5021870693271, 394.36704089935654, 13006.609801705941, 16590.25343859526, 17255.827441725563, 18578.72131918019, 18597.721034184466, 17453.476395708116, 17876.82123178771, 17902.910485447555, 17915.0, 18273.17770700322, 4844.781984810683, 5183.092958732225, 5188.688678679272, 5188.948110518903, 5190.0, 3758.7220345082665, 5061.721605311706, 5781.306243250816, 6081.270247570298, 6095.451409373156, 6063.605865618742, 6086.208792856923, 6130.478909292716, 6131.3562075982045, 6131.816045518642, 5198.8700282493055, 5583.134614134816, 5586.776528938817, 5639.971800141014, 5658.971705141489, 5275.0, 5378.354597448292, 5474.534664553517, 5474.863128421782, 5475.5072043516275, 12636.620901372973, 12734.235945843186, 12773.0, 12844.807327890088, 13233.801492977613, 1763.5943732941496, 1784.0366202250768, 1852.786929503111, 2091.7176181215495, 2430.1737409280754, 9112.0, 9225.215856652192, 9439.197668198143, 9736.0, 9755.951220243924, 1723.1901006526912, 1739.5216315513335, 1782.073321872632, 1845.372573325076, 1853.9073046347628, 65579.3442065578, 72874.0, 73312.26687733107, 74745.25254747437, 74868.99999999946, 9239.861402078974, 9765.853512197322, 10352.53413596375, 10468.110210632029, 10548.630797922036, 26889.462210756068, 27541.31146721308, 28495.0, 29805.0, 29816.0, 8944.105589441004, 8979.0, 9221.123993220634, 9365.906340936639, 9434.764130896645, 7550.0, 7735.1491335953, 7847.2152784721075, 7991.600419978978, 8091.352691784643, 8232.670693172326, 8410.158984101663, 8499.280230326236, 8538.402311838112, 8549.615267312985, 3067.8312692801665, 3127.8748850045745, 3354.9832250839077, 3404.4382676858536, 3428.3486137633768, 774.31859963232, 809.1665584448028, 826.7395770332446, 868.079835374505, 893.718478679214, 16878.24047917822, 17752.644947101246, 17773.20020599076, 17836.286548538174, 18117.90941045313, 815.5066184958133, 845.3786466946789, 867.6225841758855, 906.2840356118593, 922.8431166701677, 9578.425294482353, 9947.950260248652, 9966.2525310602, 9979.201663866874, 10140.087392134743, 338025.0, 347959.0, 350462.0, 350710.0, 350823.0, 48353.758231208616, 50561.74719126381, 74299.0, 75311.24688753152, 81950.59024704839, 907.6051917415813, 914.6707185413379, 917.7843206846386, 942.3262367407336, 944.3531181140941, 12469.625911222678, 15594.532164035098, 15756.0, 16428.589285267964, 16875.831241687425, 36050.0, 36598.8170059148, 37884.05289867776, 39100.0, 39687.80156099201, 52444.0, 54886.0, 56108.43891561032, 56409.71795140998, 56739.0, 7308.378787803096, 7472.887906681295, 7505.099388073466, 7700.537967721954, 7728.343090837342, 6655.733770649314, 10889.78220435571, 11373.20387572895, 11570.826437603275, 11627.18609697347, 9703.272254580794, 9931.900680993098, 10070.99290070987, 10154.796904062025, 10543.051125398752, 9741.707748767549, 9859.0, 9948.900510994798, 9989.60041598357, 10114.241431892491, 5436.211749296409, 6467.611943283418, 9252.380833354271, 10350.844737329096, 10507.684769456928, 7526.360259378014, 7579.431542634435, 7600.923990760243, 7699.422543309386, 7717.459777815499, 9503.619855205714, 9835.0, 9842.950785246028, 9959.950200248952, 10091.091801737879], "value": 8599.590044169567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.1690768631133, 1416.6670832354398, 1486.643205630649, 1670.6575152093822, 1691.7208660571014, 7542.849143017143, 7958.084820245674, 8054.033515978076, 8062.072861620923, 8063.838723225532, 6668.433183179435, 7641.656125474353, 7872.0947091084545, 7886.723964661238, 7923.722669706562, 2243.6410174372063, 2273.4202778291515, 2274.8407611467205, 2275.3174047785683, 2276.260215429992, 1868.570228847366, 2222.1333679864865, 2224.13258829056, 2263.241813992306, 2269.7616750241236, 2005.4384772263716, 2071.2750537311895, 2078.044099714133, 2095.769465358817, 2097.727295451597, 2150.827933765295, 2166.198506552578, 2171.0989939175224, 2174.4781252499442, 2224.354937068248, 2186.6610675345187, 2193.320070778064, 2193.3529608765452, 2194.1442837293466, 2194.319760874118, 8015.879761803578, 8144.552049637267, 8147.429679922408, 8149.7147599833725, 8151.959240203821, 4517.683762136652, 4665.673402861801, 4668.883277918046, 4674.228752255874, 4676.859694209179, 2620.4628051249447, 2763.2677340504783, 2764.7649949754295, 2766.0318888389106, 2768.9446211075665, 770.4760762681375, 794.9801254968614, 803.333233416263, 806.9354451643854, 819.2503858969036, 10668.253222274367, 10702.090322322534, 10729.248952573324, 10735.302205356627, 10735.946320268427, 4049.817758200888, 4105.220008198433, 4229.6827737919775, 4277.91444171121, 4306.461692288464, 9187.127222913812, 9224.907750922539, 9231.95384023089, 9239.0, 9240.445573265626, 4592.862214133581, 4609.700369475973, 4624.560666736655, 4630.189716799614, 4639.072185562901, 4123.731957422758, 4132.380142978517, 4135.648469880034, 4135.855245066408, 4157.397177409259, 3684.5946945835935, 3752.5121734174927, 3752.9437058444146, 3794.962050379516, 3808.0289526171205, 1060.3372891942536, 1209.618970024457, 1211.715246916974, 1214.0, 1221.4503473436812, 633.7274971762095, 718.3032458515232, 733.5561984998999, 805.6857825447963, 861.8276344731079, 5035.84892453227, 5383.111786555174, 5461.098918678374, 5587.329520457572, 5678.290213723285, 853.2534032721369, 859.3597769661642, 873.6985739919718, 888.8666699994923, 905.1039470923738, 3707.4994875691436, 3786.73492855503, 3790.431435284674, 3819.2170605025904, 3859.2474467479133, 9634.951825240969, 9970.451625160686, 10102.949485252526, 10112.03935626129, 10119.190464762802, 8159.388045896581, 9923.1069203772, 9924.950375248078, 9935.354201976848, 9937.701868943943, 7225.638718064076, 7493.925060749323, 7518.210587888193, 7673.386129109658, 7681.155072941972, 5638.4925356718095, 5744.975018592582, 5869.4717475427415, 5913.2608423947, 5972.044472884491, 9245.445273283625, 9314.161725444743, 9428.811423771349, 9433.858492122486, 9442.716718498456, 8708.129187081242, 9147.039560846282, 9158.129977652112, 9366.625334986524, 9511.381760185566, 6790.287019862843, 7113.964430177816, 7117.501774875916, 7121.715131394686, 7121.786346409616, 7654.349380302737, 7823.413244006836, 7824.100228473799, 7826.960865195865, 7828.804279893048, 6870.965645171742, 6996.895046574204, 7105.644717764195, 7203.351698347174, 7213.639318033972, 6950.0, 6994.370506654425, 7064.894026589708, 7175.820604484721, 7214.062171917617, 6450.741970321134, 6529.183852018497, 6530.771423000172, 6532.706028228646, 6534.281229064704, 4568.451785785727, 4717.599004084691, 4734.07685501324, 4749.477557468606, 4789.808407663654, 4803.711777293373, 4818.855434336975, 4820.638452116175, 4847.442544107332, 4886.9022619546695], "value": 4194.143675447953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5358440832302, 302.70788688915195, 308.20329448375946, 308.92276930767304, 312.88579668421033, 4549.749763762991, 4746.406699162605, 4749.121412538683, 4788.545088216622, 4802.111609352268, 4573.725576465406, 4694.427366832116, 4698.9060218795685, 4783.258594917785, 4793.712377257367, 3774.414965680324, 3779.130799916021, 3791.8862434127022, 3800.90497737556, 3831.8658846940434, 3577.749557530974, 3617.4935509028755, 3778.7732736035787, 3779.4708740776314, 3800.524934383202, 3671.7246206534483, 3718.2005868738215, 3744.9625503745024, 3747.9250414991684, 3765.077555998784, 3729.0863738384, 3738.719596030295, 3740.663340299386, 3742.6818720408796, 3755.4179102239195, 3316.8507417166284, 3319.3029463812627, 3319.9834000830083, 3320.8505617247283, 3329.067860998924, 4513.977430112861, 4612.746298953556, 4621.930671039937, 4652.116097941414, 4707.693999889996, 4253.744775313491, 4275.337322714984, 4277.165952639206, 4295.871123866258, 4296.548862369469, 4919.2129259318335, 4922.729249891255, 4925.729084900329, 4940.678855874393, 4984.37695288089, 3373.949390759116, 3590.6409359064146, 3632.745707800455, 3653.0867283179205, 3657.3051120287328, 5126.820561280375, 5144.6913185209005, 5154.561862241677, 5168.250603662485, 5172.7155006475, 3621.5654121505586, 3621.927561448809, 3641.8361173747244, 3646.288973650113, 3651.908702282411, 3720.311742327678, 3727.459518369821, 3729.179580492287, 3730.7201959852578, 3743.1016556026357, 4002.839886404511, 4195.265828480004, 4205.0, 4220.366944958281, 4258.871399079247, 4986.401631804207, 4992.625553083533, 5002.474740152305, 5025.572826309804, 5060.038592667382, 1184.7215904262491, 1236.4930378544934, 1258.653870185688, 1269.1560112525067, 1276.342683517989, 852.1138016462933, 858.7981824271292, 872.7818045488627, 873.7160422862595, 882.179572997106, 4384.517703052662, 4388.648908087345, 4394.099209662011, 4397.780110994438, 4400.44994375703, 5083.38999320084, 5131.846044618667, 5132.820351287687, 5153.845384638467, 5160.690358578498, 4368.7815609219415, 4373.606375426163, 4399.5160532341415, 4402.0, 4407.933880991788, 2359.2686267257204, 2427.684401027855, 2446.865422401785, 2449.6815413996064, 2472.6291056341333, 4320.524742278347, 4327.307630779061, 4336.674749393808, 4339.327404252346, 4372.846950356722, 4582.037772067836, 4591.839285625054, 4639.884002899887, 4655.348251244828, 4660.207764680013, 4130.987907962508, 4272.893177670521, 4301.720388174758, 4317.84887528935, 4338.956610433918, 4523.864284071483, 4550.111703642951, 4565.931511027404, 4567.06375193078, 4571.245744452128, 4469.530699276529, 4493.517139343943, 4500.144972455223, 4503.234450143549, 4565.7488838112895, 4139.730917490354, 4270.594293542109, 4292.720973136736, 4300.591443812833, 4326.956730432656, 3310.6095439915775, 3333.533305337206, 3341.849616767203, 3356.9328613428083, 3366.848491817923, 4540.682152249311, 4545.6136228420955, 4560.3843481129625, 4597.816087356468, 4896.751328411232, 4726.97636511829, 4951.183054795918, 4975.726335051462, 4991.376077990251, 5015.64890457679, 4942.481039490802, 4943.8516844494725, 4960.330355401975, 4980.427250866197, 4999.175136102503, 4705.64707646921, 4912.901741965212, 4913.1893237615395, 4927.310176575211, 4946.62900282473, 4989.401271847401, 4990.451050384382, 4994.850154495371, 5008.6744361616375, 5014.272930424995, 4885.731284779371, 4894.559489645949, 4900.632452566, 4936.284238785284, 4945.77744001528], "value": 3665.0276642268955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4496043481737, 634.3371177119909, 644.5037321262625, 728.6903066196865, 756.8070142113762, 12065.034797216224, 12949.287789171593, 13001.609951701465, 13060.73878522429, 13069.08516403851, 11718.707032324175, 13279.26964016981, 13372.933135334333, 13417.329133543333, 13501.932490337535, 776.0609662308599, 794.4915254237293, 797.788586024701, 798.9960050199741, 799.9600019999006, 781.5662307419379, 783.7648705388389, 783.8549868274388, 784.7802615267734, 785.1716439156687, 838.8322335532887, 839.6725277141919, 839.6935118681698, 841.0706169682504, 842.4692443760453, 829.7054545636272, 829.9377546683993, 830.4187069051688, 830.6303694855792, 830.8172202115585, 612.2102487790745, 612.9478994285491, 613.0344707086313, 613.1630324606924, 614.5206738743786, 12511.624651260478, 12679.049071319596, 12685.365731713377, 12698.365081745877, 12699.428525716365, 10330.690079297634, 10439.686809395731, 10530.15758739299, 10605.151587873028, 10792.730181745519, 9413.48225847578, 9454.763630909283, 9615.51922403877, 9668.0, 9793.363431376938, 3127.7654175936896, 3175.3490534440384, 3177.3327601203546, 3180.936381272362, 3202.679732026802, 53594.73202634001, 60387.698061509414, 61242.0, 61856.0, 62274.37725622731, 9759.072888075621, 9834.704958851104, 10385.896141038493, 10498.790024199474, 10562.577496900038, 17878.463646090637, 17880.821191787916, 17880.821191787916, 17889.910550447425, 17899.73150402745, 6766.28953959837, 6959.0, 6975.651217439107, 7050.048243487064, 7158.60627665473, 3591.4612808078473, 3663.358912190356, 3683.0478756599678, 3706.4440333950124, 3717.0893131182493, 2759.0343379816904, 2875.051233093074, 2878.064628995585, 2880.683124856264, 2883.178294186147, 486.41144215498934, 491.13314999026744, 502.29427654145985, 502.9069622119919, 503.1597232621531, 485.18488938583516, 507.11508417811154, 512.9589632829365, 519.6232731269874, 524.8189374665734, 7107.75122870697, 7530.43521735861, 7595.810104747315, 7621.542707437571, 7621.733239336597, 399.0980384331374, 452.2560388161456, 464.31565527539084, 477.6608607888369, 498.9920360871093, 3462.7056700180765, 3562.305350456636, 3677.9448308275396, 3684.097396137963, 3732.1789206374556, 53002.734986324824, 53145.202821957704, 54246.45753542493, 72186.0, 75277.0, 75655.62172189103, 78102.6094869522, 79633.60183199047, 79674.20325796668, 80679.59660201661, 43460.78269608632, 44261.0, 66095.0, 69661.3033869665, 70830.0, 7758.3017528422715, 7782.027246594176, 7821.178776228641, 7918.1610205896895, 8021.799455013671, 43257.0, 43706.34440483459, 44333.33499997438, 44348.0, 44501.777491112334, 52810.471895280556, 53866.73066634642, 53966.73016634892, 54035.0, 57156.85637289989, 9469.47917864524, 9772.706818795448, 9822.5088745561, 10121.848172277569, 10226.6420675276, 11184.776304473702, 11379.658610241706, 11833.881661183623, 12011.399430028288, 12613.558525451564, 10856.891431085589, 11015.614453494089, 11430.657080287605, 11818.231814932002, 12439.875601244234, 10756.731081723019, 10854.837177442503, 11300.717482062686, 11333.659990200307, 11334.093272538343, 11598.47806848677, 11622.6513204604, 11691.824622630838, 12239.816402754144, 12318.876811232132, 9488.430694158373, 9862.457564834003, 10374.221933354878, 10386.948065259625, 10399.84400233982, 9478.289128315542, 9516.19112375456, 9524.666636667684, 9669.226461883172, 9845.212383009486], "value": 6174.788518870111, "unit": "score"}], "name": "dromaeo_css", "value": 6237.590369978101, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 123.0, 175.0, 123.0, 122.0, 151.0, 122.0, 166.0, 123.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 76.0, 118.0, 76.0, 77.0, 74.0, 74.0, 102.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 114.0, 85.0, 85.0, 86.0, 121.0, 85.0, 84.0, 128.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 65.0, 63.0, 64.0, 65.0, 63.0, 64.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 81.0, 79.0, 78.0, 81.0, 80.0, 79.0, 77.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 129.0, 132.0, 133.0, 136.0, 129.0, 135.0, 168.0, 129.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 167.0, 167.0, 167.0, 166.0, 166.0, 170.0, 165.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 69.0, 66.0, 64.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1524.7, "alertThreshold": 2.0}]} 10:57:49 INFO - Return code: 0 10:57:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:57:49 INFO - # TBPL SUCCESS # 10:57:49 INFO - Running post-action listener: _resource_record_post_action 10:57:49 INFO - ##### 10:57:49 INFO - ##### Finished run-tests step (success) 10:57:49 INFO - ##### 10:57:49 INFO - Running post-run listener: _resource_record_post_run 10:57:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548966400; Read time: 424; Write time: 551368 10:57:49 INFO - TinderboxPrint: CPU usage
13.0% 10:57:49 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 424 10:57:49 INFO - TinderboxPrint: I/O write bytes / time
548,966,400 / 551,368 10:57:49 INFO - TinderboxPrint: CPU idle
8,315.4 (87.0%) 10:57:49 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 10:57:49 INFO - TinderboxPrint: Swap in / out
0 / 0 10:57:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260173824; Read time: 0; Write time: 307444 10:57:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288792576; Read time: 424; Write time: 243924 10:57:50 INFO - Running post-run listener: _upload_blobber_files 10:57:50 INFO - Blob upload gear active. 10:57:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:57:50 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 10:57:50 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'] 10:57:50 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 10:57:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:54 INFO - (blobuploader) - INFO - Done attempting. 10:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:54 INFO - (blobuploader) - INFO - Done attempting. 10:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:57:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:55 INFO - (blobuploader) - INFO - Done attempting. 10:57:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:57:55 INFO - Return code: 0 10:57:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:57:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:57:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6600f933f864ea24440ddea352d26d24bd0da27d5d39ff8eefac5f30f5b159cc6570cdb9af5832d34384806a21f3226466721810794028481db07cba747087c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810650409689e5bca395826341416028a27c60dbdd7185290243735102f531a6586d44f46db08e9f41a8175207be40a1f6bfa12d58020394dcdd68380cc7abad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9763f8fe49cbb91bf39f8c2b9255f34af67b0c705a29938d26ac327dd32e8780da46f1c03944445416ba5d64c0e127f3aa0a61ec92d988678e18cc6f4a45da"} 10:57:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:57:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:57:55 INFO - Contents: 10:57:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6600f933f864ea24440ddea352d26d24bd0da27d5d39ff8eefac5f30f5b159cc6570cdb9af5832d34384806a21f3226466721810794028481db07cba747087c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810650409689e5bca395826341416028a27c60dbdd7185290243735102f531a6586d44f46db08e9f41a8175207be40a1f6bfa12d58020394dcdd68380cc7abad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9763f8fe49cbb91bf39f8c2b9255f34af67b0c705a29938d26ac327dd32e8780da46f1c03944445416ba5d64c0e127f3aa0a61ec92d988678e18cc6f4a45da"} 10:57:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:57:55 INFO - Copying logs to upload dir... 10:57:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:57:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.171542 ========= master_lag: 8.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-13 10:58:04.201534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:58:04.204784) ========= 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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 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/f6600f933f864ea24440ddea352d26d24bd0da27d5d39ff8eefac5f30f5b159cc6570cdb9af5832d34384806a21f3226466721810794028481db07cba747087c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810650409689e5bca395826341416028a27c60dbdd7185290243735102f531a6586d44f46db08e9f41a8175207be40a1f6bfa12d58020394dcdd68380cc7abad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9763f8fe49cbb91bf39f8c2b9255f34af67b0c705a29938d26ac327dd32e8780da46f1c03944445416ba5d64c0e127f3aa0a61ec92d988678e18cc6f4a45da"} build_url:https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/F67D-8VfSReJFjTOqCms5g/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/f6600f933f864ea24440ddea352d26d24bd0da27d5d39ff8eefac5f30f5b159cc6570cdb9af5832d34384806a21f3226466721810794028481db07cba747087c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810650409689e5bca395826341416028a27c60dbdd7185290243735102f531a6586d44f46db08e9f41a8175207be40a1f6bfa12d58020394dcdd68380cc7abad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9763f8fe49cbb91bf39f8c2b9255f34af67b0c705a29938d26ac327dd32e8780da46f1c03944445416ba5d64c0e127f3aa0a61ec92d988678e18cc6f4a45da"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:58:04.343153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:58:04.343492) ========= 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=32c5991c409366f7fec8a718000001d2-1468431046.658185-1852922037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:58:04.359989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:58:04.360315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:58:04.360622) ========= ========= Total master_lag: 8.89 =========