builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1468503894.91 results: success (0) buildid: 20160714033529 builduid: e5a53da1c33441ef84834b57e1ca3076 revision: d868ba1645e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:54.908275) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:54.908753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:54.909044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:55.063092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:55.063421) ========= 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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:44:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.2M=0s 2016-07-14 06:44:55 (26.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.363080 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:55.602077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:55.602402) ========= 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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016178 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:55.631935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:44:55.632276) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d868ba1645e6 --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 d868ba1645e6 --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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:44:55,715 Setting DEBUG logging. 2016-07-14 06:44:55,715 attempt 1/10 2016-07-14 06:44:55,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d868ba1645e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:44:57,044 unpacking tar archive at: fx-team-d868ba1645e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.688390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:44:57.334023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:57.334343) ========= script_repo_revision: d868ba1645e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:57.334768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:57.335035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:44:57.344428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-14 06:44:57.344837) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:57 INFO - MultiFileLogger online at 20160714 06:44:57 in /builds/slave/test 06:44:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:44:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:57 INFO - {'append_to_log': False, 06:44:57 INFO - 'base_work_dir': '/builds/slave/test', 06:44:57 INFO - 'blob_upload_branch': 'Fx-Team', 06:44:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:57 INFO - 'branch': 'Fx-Team', 06:44:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:57 INFO - 'config_files': ('talos/linux_config.py',), 06:44:57 INFO - 'default_actions': ('clobber', 06:44:57 INFO - 'read-buildbot-config', 06:44:57 INFO - 'download-and-extract', 06:44:57 INFO - 'populate-webroot', 06:44:57 INFO - 'create-virtualenv', 06:44:57 INFO - 'install', 06:44:57 INFO - 'run-tests'), 06:44:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:57 INFO - 'download_minidump_stackwalk': True, 06:44:57 INFO - 'download_symbols': 'ondemand', 06:44:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:57 INFO - 'installer_path': 'installer.exe', 06:44:57 INFO - 'log_level': 'info', 06:44:57 INFO - 'log_name': 'talos', 06:44:57 INFO - 'log_to_console': True, 06:44:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:57 INFO - 'opt_config_files': (), 06:44:57 INFO - 'pip_index': False, 06:44:57 INFO - 'sps_profile': False, 06:44:57 INFO - 'sps_profile_interval': 0, 06:44:57 INFO - 'suite': 'dromaeojs', 06:44:57 INFO - 'system_bits': '32', 06:44:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:57 INFO - 'title': 'talos-linux64-ix-020', 06:44:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:57 INFO - 'use_talos_json': True, 06:44:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:57 INFO - 'work_dir': 'build'} 06:44:57 INFO - ##### 06:44:57 INFO - ##### Running clobber step. 06:44:57 INFO - ##### 06:44:57 INFO - Running pre-action listener: _resource_record_pre_action 06:44:57 INFO - Running main action method: clobber 06:44:57 INFO - rmtree: /builds/slave/test/build 06:44:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:57 INFO - Running post-action listener: _resource_record_post_action 06:44:57 INFO - ##### 06:44:57 INFO - ##### Finished clobber step (success) 06:44:57 INFO - ##### 06:44:57 INFO - ##### 06:44:57 INFO - ##### Running read-buildbot-config step. 06:44:57 INFO - ##### 06:44:57 INFO - Running pre-action listener: _resource_record_pre_action 06:44:57 INFO - Running main action method: read_buildbot_config 06:44:57 INFO - Using buildbot properties: 06:44:57 INFO - { 06:44:57 INFO - "project": "", 06:44:57 INFO - "product": "firefox", 06:44:57 INFO - "script_repo_revision": "production", 06:44:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:44:57 INFO - "repository": "", 06:44:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:44:57 INFO - "buildid": "20160714033529", 06:44:57 INFO - "pgo_build": "True", 06:44:57 INFO - "basedir": "/builds/slave/test", 06:44:57 INFO - "buildnumber": 287, 06:44:57 INFO - "slavename": "talos-linux64-ix-020", 06:44:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:44:57 INFO - "platform": "ubuntu64_hw", 06:44:57 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:44:57 INFO - "branch": "fx-team", 06:44:57 INFO - "repo_path": "integration/fx-team", 06:44:57 INFO - "revision": "d868ba1645e6", 06:44:57 INFO - "stage_platform": "linux64-pgo", 06:44:57 INFO - "builduid": "e5a53da1c33441ef84834b57e1ca3076", 06:44:57 INFO - "slavebuilddir": "test" 06:44:57 INFO - } 06:44:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:44:57 INFO - Running post-action listener: _resource_record_post_action 06:44:57 INFO - ##### 06:44:57 INFO - ##### Finished read-buildbot-config step (success) 06:44:57 INFO - ##### 06:44:57 INFO - ##### 06:44:57 INFO - ##### Running download-and-extract step. 06:44:57 INFO - ##### 06:44:57 INFO - Running pre-action listener: _resource_record_pre_action 06:44:57 INFO - Running main action method: download_and_extract 06:44:57 INFO - mkdir: /builds/slave/test/build/tests 06:44:57 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')]} 06:44:57 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:44:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:44:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:44:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:44:58 INFO - Downloaded 1361 bytes. 06:44:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:44:58 INFO - Using the following test package requirements: 06:44:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:44:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:44:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'jsshell-linux-x86_64.zip'], 06:44:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:44:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:44:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:44:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:44:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:44:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:58 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:44:59 INFO - Downloaded 24326501 bytes. 06:44:59 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'] 06:44:59 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 06:45:00 INFO - Return code: 0 06:45:01 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 06:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:01 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:03 INFO - Downloaded 24326501 bytes. 06:45:03 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'] 06:45:03 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 06:45:04 INFO - Return code: 0 06:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:04 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:05 INFO - Downloaded 14403317 bytes. 06:45:05 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'] 06:45:05 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 06:45:06 INFO - Return code: 0 06:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:06 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:45:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:45:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:45:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/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 06:45:07 INFO - Downloaded 60816815 bytes. 06:45:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:45:07 INFO - mkdir: /builds/slave/test/properties 06:45:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:45:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:45:07 INFO - Contents: 06:45:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:45:08 INFO - Running post-action listener: _resource_record_post_action 06:45:08 INFO - Running post-action listener: set_extra_try_arguments 06:45:08 INFO - ##### 06:45:08 INFO - ##### Finished download-and-extract step (success) 06:45:08 INFO - ##### 06:45:08 INFO - ##### 06:45:08 INFO - ##### Running populate-webroot step. 06:45:08 INFO - ##### 06:45:08 INFO - Running pre-action listener: _resource_record_pre_action 06:45:08 INFO - Running main action method: populate_webroot 06:45:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:45:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:45:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:45:08 INFO - '--tppagecycles', 06:45:08 INFO - '7'], 06:45:08 INFO - 'tests': ['tsvgm']}}, 06:45:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:45:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:45:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:45:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:45:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:45:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['damp', 'tps']}, 06:45:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'tests': ['damp', 'tps']}, 06:45:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['dromaeo_dom']}, 06:45:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:45:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['basic_compositor_video']}, 06:45:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:45:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'other-e10s': {'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['a11yr', 06:45:08 INFO - 'ts_paint', 06:45:08 INFO - 'tpaint', 06:45:08 INFO - 'sessionrestore', 06:45:08 INFO - 'sessionrestore_no_auto_restore', 06:45:08 INFO - 'tabpaint']}, 06:45:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['tsvgx', 06:45:08 INFO - 'tsvgr_opacity', 06:45:08 INFO - 'tart', 06:45:08 INFO - 'tscrollx', 06:45:08 INFO - 'cart']}, 06:45:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:45:08 INFO - 'tsvgr_opacity', 06:45:08 INFO - 'tart', 06:45:08 INFO - 'tscrollx', 06:45:08 INFO - 'cart']}, 06:45:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'talos_options': ['--disable-e10s'], 06:45:08 INFO - 'tests': ['tp5o']}, 06:45:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'tests': ['tp5o']}, 06:45:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'talos_options': ['--disable-e10s', 06:45:08 INFO - '--xperf_path', 06:45:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:08 INFO - 'tests': ['tp5n']}, 06:45:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:45:08 INFO - 'talos_options': ['--xperf_path', 06:45:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:45:08 INFO - 'tests': ['tp5n']}}, 06:45:08 INFO - 'talos.zip': {'path': '', 06:45:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:45:08 INFO - Running post-action listener: _resource_record_post_action 06:45:08 INFO - ##### 06:45:08 INFO - ##### Finished populate-webroot step (success) 06:45:08 INFO - ##### 06:45:08 INFO - ##### 06:45:08 INFO - ##### Running create-virtualenv step. 06:45:08 INFO - ##### 06:45:08 INFO - Running pre-action listener: _resource_record_pre_action 06:45:08 INFO - Running main action method: create_virtualenv 06:45:08 INFO - Creating virtualenv /builds/slave/test/build/venv 06:45:08 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 06:45:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:45:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:45:08 INFO - Using real prefix '/usr' 06:45:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:45:08 INFO - Installing distribute.............................................................................................................................................................................................done. 06:45:10 INFO - Installing pip.................done. 06:45:10 INFO - Return code: 0 06:45:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:45:10 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')]} 06:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:10 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')]} 06:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:10 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:10 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 06:45:10 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 06:45:10 INFO - Using env: {'DISPLAY': ':0', 06:45:10 INFO - 'HOME': '/home/cltbld', 06:45:10 INFO - 'LANG': 'en_US.UTF-8', 06:45:10 INFO - 'LANGUAGE': 'en_US:en', 06:45:10 INFO - 'LOGNAME': 'cltbld', 06:45:10 INFO - 'MAIL': '/var/mail/cltbld', 06:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:10 INFO - 'MOZ_NO_REMOTE': '1', 06:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:10 INFO - 'NO_EM_RESTART': '1', 06:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:10 INFO - 'PWD': '/builds/slave/test', 06:45:10 INFO - 'SHELL': '/bin/bash', 06:45:10 INFO - 'SHLVL': '1', 06:45:10 INFO - 'TERM': 'linux', 06:45:10 INFO - 'TMOUT': '86400', 06:45:10 INFO - 'USER': 'cltbld', 06:45:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:10 INFO - '_': '/tools/buildbot/bin/python'} 06:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:11 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 06:45:11 INFO - Cleaning up... 06:45:11 INFO - Return code: 0 06:45:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:45:11 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')]} 06:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:11 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')]} 06:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:11 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:11 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 06:45:11 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 06:45:11 INFO - Using env: {'DISPLAY': ':0', 06:45:11 INFO - 'HOME': '/home/cltbld', 06:45:11 INFO - 'LANG': 'en_US.UTF-8', 06:45:11 INFO - 'LANGUAGE': 'en_US:en', 06:45:11 INFO - 'LOGNAME': 'cltbld', 06:45:11 INFO - 'MAIL': '/var/mail/cltbld', 06:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:11 INFO - 'MOZ_NO_REMOTE': '1', 06:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:11 INFO - 'NO_EM_RESTART': '1', 06:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:11 INFO - 'PWD': '/builds/slave/test', 06:45:11 INFO - 'SHELL': '/bin/bash', 06:45:11 INFO - 'SHLVL': '1', 06:45:11 INFO - 'TERM': 'linux', 06:45:11 INFO - 'TMOUT': '86400', 06:45:11 INFO - 'USER': 'cltbld', 06:45:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:11 INFO - '_': '/tools/buildbot/bin/python'} 06:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:11 INFO - Downloading/unpacking psutil>=3.1.1 06:45:11 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 06:45:11 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 06:45:11 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 06:45:11 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 06:45:11 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 06:45:11 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 06:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:45:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:13 INFO - Installing collected packages: psutil 06:45:13 INFO - Running setup.py install for psutil 06:45:13 INFO - building 'psutil._psutil_linux' extension 06:45:13 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 06:45:13 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 06:45:13 INFO - building 'psutil._psutil_posix' extension 06:45:13 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 06:45:13 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 06:45:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:45:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:45:13 INFO - Successfully installed psutil 06:45:13 INFO - Cleaning up... 06:45:13 INFO - Return code: 0 06:45:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:45:13 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')]} 06:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:13 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')]} 06:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:13 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:13 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 06:45:13 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 06:45:13 INFO - Using env: {'DISPLAY': ':0', 06:45:13 INFO - 'HOME': '/home/cltbld', 06:45:13 INFO - 'LANG': 'en_US.UTF-8', 06:45:13 INFO - 'LANGUAGE': 'en_US:en', 06:45:13 INFO - 'LOGNAME': 'cltbld', 06:45:13 INFO - 'MAIL': '/var/mail/cltbld', 06:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:13 INFO - 'MOZ_NO_REMOTE': '1', 06:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:13 INFO - 'NO_EM_RESTART': '1', 06:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:13 INFO - 'PWD': '/builds/slave/test', 06:45:13 INFO - 'SHELL': '/bin/bash', 06:45:13 INFO - 'SHLVL': '1', 06:45:13 INFO - 'TERM': 'linux', 06:45:13 INFO - 'TMOUT': '86400', 06:45:13 INFO - 'USER': 'cltbld', 06:45:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:13 INFO - '_': '/tools/buildbot/bin/python'} 06:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:45:14 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 06:45:14 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 06:45:14 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 06:45:14 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 06:45:14 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 06:45:14 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 06:45:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:45:16 INFO - Installing collected packages: mozsystemmonitor 06:45:16 INFO - Running setup.py install for mozsystemmonitor 06:45:16 INFO - Successfully installed mozsystemmonitor 06:45:16 INFO - Cleaning up... 06:45:16 INFO - Return code: 0 06:45:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:45:16 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')]} 06:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:16 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')]} 06:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:16 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:16 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 06:45:16 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 06:45:16 INFO - Using env: {'DISPLAY': ':0', 06:45:16 INFO - 'HOME': '/home/cltbld', 06:45:16 INFO - 'LANG': 'en_US.UTF-8', 06:45:16 INFO - 'LANGUAGE': 'en_US:en', 06:45:16 INFO - 'LOGNAME': 'cltbld', 06:45:16 INFO - 'MAIL': '/var/mail/cltbld', 06:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:16 INFO - 'MOZ_NO_REMOTE': '1', 06:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:16 INFO - 'NO_EM_RESTART': '1', 06:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:16 INFO - 'PWD': '/builds/slave/test', 06:45:16 INFO - 'SHELL': '/bin/bash', 06:45:16 INFO - 'SHLVL': '1', 06:45:16 INFO - 'TERM': 'linux', 06:45:16 INFO - 'TMOUT': '86400', 06:45:16 INFO - 'USER': 'cltbld', 06:45:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:16 INFO - '_': '/tools/buildbot/bin/python'} 06:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:16 INFO - Downloading/unpacking jsonschema==2.5.1 06:45:16 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 06:45:16 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 06:45:16 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 06:45:16 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 06:45:16 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 06:45:16 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 06:45:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:45:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 INFO - Downloading functools32-3.2.3-2.tar.gz 06:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:45:18 INFO - warning: no files found matching '*.txt' 06:45:18 INFO - no previously-included directories found matching 'build' 06:45:18 INFO - no previously-included directories found matching 'dist' 06:45:18 INFO - no previously-included directories found matching '.git*' 06:45:18 INFO - Installing collected packages: jsonschema, functools32 06:45:18 INFO - Running setup.py install for functools32 06:45:18 INFO - warning: no files found matching '*.txt' 06:45:18 INFO - no previously-included directories found matching 'build' 06:45:18 INFO - no previously-included directories found matching 'dist' 06:45:18 INFO - no previously-included directories found matching '.git*' 06:45:18 INFO - Successfully installed jsonschema functools32 06:45:18 INFO - Cleaning up... 06:45:18 INFO - Return code: 0 06:45:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:18 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:18 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 06:45:18 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 06:45:18 INFO - Using env: {'DISPLAY': ':0', 06:45:18 INFO - 'HOME': '/home/cltbld', 06:45:18 INFO - 'LANG': 'en_US.UTF-8', 06:45:18 INFO - 'LANGUAGE': 'en_US:en', 06:45:18 INFO - 'LOGNAME': 'cltbld', 06:45:18 INFO - 'MAIL': '/var/mail/cltbld', 06:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:18 INFO - 'MOZ_NO_REMOTE': '1', 06:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:18 INFO - 'NO_EM_RESTART': '1', 06:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:18 INFO - 'PWD': '/builds/slave/test', 06:45:18 INFO - 'SHELL': '/bin/bash', 06:45:18 INFO - 'SHLVL': '1', 06:45:18 INFO - 'TERM': 'linux', 06:45:18 INFO - 'TMOUT': '86400', 06:45:18 INFO - 'USER': 'cltbld', 06:45:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:18 INFO - '_': '/tools/buildbot/bin/python'} 06:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:18 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 06:45:20 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45:20 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 06:45:20 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 06:45:20 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 06:45:20 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 06:45:20 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 06:45:20 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 06:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45:21 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 06:45:21 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 06:45:21 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 06:45:21 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 06:45:21 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 06:45:21 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 06:45:21 INFO - Downloading docopt-0.6.1.tar.gz 06:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:21 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:21 INFO - Running setup.py install for blobuploader 06:45:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:21 INFO - Running setup.py install for requests 06:45:22 INFO - Running setup.py install for docopt 06:45:22 INFO - Successfully installed blobuploader requests docopt 06:45:22 INFO - Cleaning up... 06:45:22 INFO - Return code: 0 06:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:22 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:22 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 06:45:22 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 06:45:22 INFO - Using env: {'DISPLAY': ':0', 06:45:22 INFO - 'HOME': '/home/cltbld', 06:45:22 INFO - 'LANG': 'en_US.UTF-8', 06:45:22 INFO - 'LANGUAGE': 'en_US:en', 06:45:22 INFO - 'LOGNAME': 'cltbld', 06:45:22 INFO - 'MAIL': '/var/mail/cltbld', 06:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:22 INFO - 'MOZ_NO_REMOTE': '1', 06:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:22 INFO - 'NO_EM_RESTART': '1', 06:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:22 INFO - 'PWD': '/builds/slave/test', 06:45:22 INFO - 'SHELL': '/bin/bash', 06:45:22 INFO - 'SHLVL': '1', 06:45:22 INFO - 'TERM': 'linux', 06:45:22 INFO - 'TMOUT': '86400', 06:45:22 INFO - 'USER': 'cltbld', 06:45:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:22 INFO - '_': '/tools/buildbot/bin/python'} 06:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:22 INFO - Running setup.py (path:/tmp/pip-xtq3yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:22 INFO - Running setup.py (path:/tmp/pip-8OXjkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:22 INFO - Running setup.py (path:/tmp/pip-vpSGr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:22 INFO - Running setup.py (path:/tmp/pip-FjrPh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:22 INFO - Running setup.py (path:/tmp/pip-CZFUkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:22 INFO - Running setup.py (path:/tmp/pip-MwWOeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:22 INFO - Running setup.py (path:/tmp/pip-mZFyJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:23 INFO - Running setup.py (path:/tmp/pip-upFTRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:23 INFO - Running setup.py (path:/tmp/pip-5kSypN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:23 INFO - Running setup.py (path:/tmp/pip-62CAKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:23 INFO - Running setup.py (path:/tmp/pip-kgAvXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:23 INFO - Running setup.py (path:/tmp/pip-HSshoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:23 INFO - Running setup.py (path:/tmp/pip-z9YlsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:23 INFO - Running setup.py (path:/tmp/pip-M1sdE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:23 INFO - Running setup.py (path:/tmp/pip-VEhSp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:23 INFO - Running setup.py (path:/tmp/pip-bbrrjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:23 INFO - Running setup.py (path:/tmp/pip-je5IB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:23 INFO - Running setup.py install for manifestparser 06:45:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:23 INFO - Running setup.py install for mozcrash 06:45:23 INFO - Running setup.py install for mozdebug 06:45:24 INFO - Running setup.py install for mozdevice 06:45:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for mozfile 06:45:24 INFO - Running setup.py install for mozhttpd 06:45:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for mozinfo 06:45:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for mozInstall 06:45:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for mozleak 06:45:24 INFO - Running setup.py install for mozlog 06:45:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for moznetwork 06:45:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:24 INFO - Running setup.py install for mozprocess 06:45:24 INFO - Running setup.py install for mozprofile 06:45:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:25 INFO - Running setup.py install for mozrunner 06:45:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:25 INFO - Running setup.py install for mozscreenshot 06:45:25 INFO - Running setup.py install for moztest 06:45:25 INFO - Running setup.py install for mozversion 06:45:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:25 INFO - Cleaning up... 06:45:25 INFO - Return code: 0 06:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45: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')]} 06:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:25 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:25 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 06:45:25 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 06:45:25 INFO - Using env: {'DISPLAY': ':0', 06:45:25 INFO - 'HOME': '/home/cltbld', 06:45:25 INFO - 'LANG': 'en_US.UTF-8', 06:45:25 INFO - 'LANGUAGE': 'en_US:en', 06:45:25 INFO - 'LOGNAME': 'cltbld', 06:45:25 INFO - 'MAIL': '/var/mail/cltbld', 06:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:25 INFO - 'MOZ_NO_REMOTE': '1', 06:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:25 INFO - 'NO_EM_RESTART': '1', 06:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:25 INFO - 'PWD': '/builds/slave/test', 06:45:25 INFO - 'SHELL': '/bin/bash', 06:45:25 INFO - 'SHLVL': '1', 06:45:25 INFO - 'TERM': 'linux', 06:45:25 INFO - 'TMOUT': '86400', 06:45:25 INFO - 'USER': 'cltbld', 06:45:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:25 INFO - '_': '/tools/buildbot/bin/python'} 06:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:25 INFO - Running setup.py (path:/tmp/pip-fYFFV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:25 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)) 06:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:25 INFO - Running setup.py (path:/tmp/pip-rrQ5VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:25 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)) 06:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:25 INFO - Running setup.py (path:/tmp/pip-BOZLVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:25 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)) 06:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:25 INFO - Running setup.py (path:/tmp/pip-VDAV8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:26 INFO - Running setup.py (path:/tmp/pip-OmGmke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:26 INFO - Running setup.py (path:/tmp/pip-lLmdAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:26 INFO - Running setup.py (path:/tmp/pip-2MOBWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:26 INFO - Running setup.py (path:/tmp/pip-2sBNE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:26 INFO - Running setup.py (path:/tmp/pip-gueBDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:26 INFO - Running setup.py (path:/tmp/pip-8x10HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:26 INFO - Running setup.py (path:/tmp/pip-40s_KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:26 INFO - Running setup.py (path:/tmp/pip-zd4pH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:26 INFO - Running setup.py (path:/tmp/pip-DhR6DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:26 INFO - Running setup.py (path:/tmp/pip-zw8cDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:26 INFO - Running setup.py (path:/tmp/pip-L5EdL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:26 INFO - Running setup.py (path:/tmp/pip-9h7lct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:26 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)) 06:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:26 INFO - Running setup.py (path:/tmp/pip-GIcfBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:27 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)) 06:45:27 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)) 06:45:27 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)) 06:45:27 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)) 06:45:27 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)) 06:45:27 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)) 06:45:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:28 INFO - Downloading blessings-1.6.tar.gz 06:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:29 INFO - Installing collected packages: blessings 06:45:29 INFO - Running setup.py install for blessings 06:45:29 INFO - Successfully installed blessings 06:45:29 INFO - Cleaning up... 06:45:29 INFO - Return code: 0 06:45:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:29 INFO - Reading from file tmpfile_stdout 06:45:29 INFO - Current package versions: 06:45:29 INFO - argparse == 1.2.1 06:45:29 INFO - blessings == 1.6 06:45:29 INFO - blobuploader == 1.2.4 06:45:29 INFO - docopt == 0.6.1 06:45:29 INFO - functools32 == 3.2.3-2 06:45:29 INFO - jsonschema == 2.5.1 06:45:29 INFO - manifestparser == 1.1 06:45:29 INFO - mozInstall == 1.12 06:45:29 INFO - mozcrash == 0.17 06:45:29 INFO - mozdebug == 0.1 06:45:29 INFO - mozdevice == 0.48 06:45:29 INFO - mozfile == 1.2 06:45:29 INFO - mozhttpd == 0.7 06:45:29 INFO - mozinfo == 0.9 06:45:29 INFO - mozleak == 0.1 06:45:29 INFO - mozlog == 3.2 06:45:29 INFO - moznetwork == 0.27 06:45:29 INFO - mozprocess == 0.23 06:45:29 INFO - mozprofile == 0.28 06:45:29 INFO - mozrunner == 6.12 06:45:29 INFO - mozscreenshot == 0.1 06:45:29 INFO - mozsystemmonitor == 0.3 06:45:29 INFO - moztest == 0.7 06:45:29 INFO - mozversion == 1.4 06:45:29 INFO - psutil == 3.1.1 06:45:29 INFO - requests == 1.2.3 06:45:29 INFO - wsgiref == 0.1.2 06:45:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 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 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:29 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 06:45:29 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 06:45:29 INFO - Using env: {'DISPLAY': ':0', 06:45:29 INFO - 'HOME': '/home/cltbld', 06:45:29 INFO - 'LANG': 'en_US.UTF-8', 06:45:29 INFO - 'LANGUAGE': 'en_US:en', 06:45:29 INFO - 'LOGNAME': 'cltbld', 06:45:29 INFO - 'MAIL': '/var/mail/cltbld', 06:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:29 INFO - 'MOZ_NO_REMOTE': '1', 06:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:29 INFO - 'NO_EM_RESTART': '1', 06:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:29 INFO - 'PWD': '/builds/slave/test', 06:45:29 INFO - 'SHELL': '/bin/bash', 06:45:29 INFO - 'SHLVL': '1', 06:45:29 INFO - 'TERM': 'linux', 06:45:29 INFO - 'TMOUT': '86400', 06:45:29 INFO - 'USER': 'cltbld', 06:45:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:29 INFO - '_': '/tools/buildbot/bin/python'} 06:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 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)) 06:45:29 INFO - Cleaning up... 06:45:29 INFO - Return code: 0 06:45:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', '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 06:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:45:29 INFO - Using env: {'DISPLAY': ':0', 06:45:29 INFO - 'HOME': '/home/cltbld', 06:45:29 INFO - 'LANG': 'en_US.UTF-8', 06:45:29 INFO - 'LANGUAGE': 'en_US:en', 06:45:29 INFO - 'LOGNAME': 'cltbld', 06:45:29 INFO - 'MAIL': '/var/mail/cltbld', 06:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:29 INFO - 'MOZ_NO_REMOTE': '1', 06:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:29 INFO - 'NO_EM_RESTART': '1', 06:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:29 INFO - 'PWD': '/builds/slave/test', 06:45:29 INFO - 'SHELL': '/bin/bash', 06:45:29 INFO - 'SHLVL': '1', 06:45:29 INFO - 'TERM': 'linux', 06:45:29 INFO - 'TMOUT': '86400', 06:45:29 INFO - 'USER': 'cltbld', 06:45:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:29 INFO - '_': '/tools/buildbot/bin/python'} 06:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:45:29 INFO - Cleaning up... 06:45:29 INFO - Return code: 0 06:45:29 INFO - Running post-action listener: _resource_record_post_action 06:45:29 INFO - Running post-action listener: _start_resource_monitoring 06:45:29 INFO - Starting resource monitoring. 06:45:29 INFO - ##### 06:45:29 INFO - ##### Finished create-virtualenv step (success) 06:45:29 INFO - ##### 06:45:29 INFO - ##### 06:45:29 INFO - ##### Running install step. 06:45:29 INFO - ##### 06:45:29 INFO - Running pre-action listener: _resource_record_pre_action 06:45:29 INFO - Running main action method: install 06:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:30 INFO - Reading from file tmpfile_stdout 06:45:30 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:30 INFO - Reading from file tmpfile_stdout 06:45:30 INFO - Output received: 06:45:30 INFO - Usage: mozinstall [options] installer 06:45:30 INFO - Options: 06:45:30 INFO - -h, --help show this help message and exit 06:45:30 INFO - -d DEST, --destination=DEST 06:45:30 INFO - Directory to install application into. [default: 06:45:30 INFO - "/builds/slave/test"] 06:45:30 INFO - --app=APP Application being installed. [default: firefox] 06:45:30 INFO - mkdir: /builds/slave/test/build/application 06:45:30 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'] 06:45:30 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 06:45:47 INFO - Reading from file tmpfile_stdout 06:45:47 INFO - Output received: 06:45:47 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:47 INFO - Running post-action listener: _resource_record_post_action 06:45:47 INFO - ##### 06:45:47 INFO - ##### Finished install step (success) 06:45:47 INFO - ##### 06:45:47 INFO - ##### 06:45:47 INFO - ##### Running run-tests step. 06:45:47 INFO - ##### 06:45:47 INFO - Running pre-action listener: _resource_record_pre_action 06:45:47 INFO - Running main action method: run_tests 06:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:47 INFO - Python 2.7.3 06:45:47 INFO - Return code: 0 06:45:47 INFO - grabbing minidump binary from tooltool 06:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:47 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 0x1f7d3b0>, '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 0x1f7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:47 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 06:45:47 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 06:45:47 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 06:45:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:47 INFO - Return code: 0 06:45:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 06:45:47 INFO - Using env: {'DISPLAY': ':0', 06:45:47 INFO - 'HOME': '/home/cltbld', 06:45:47 INFO - 'LANG': 'en_US.UTF-8', 06:45:47 INFO - 'LANGUAGE': 'en_US:en', 06:45:47 INFO - 'LOGNAME': 'cltbld', 06:45:47 INFO - 'MAIL': '/var/mail/cltbld', 06:45:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:47 INFO - 'MOZ_NO_REMOTE': '1', 06:45:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:47 INFO - 'NO_EM_RESTART': '1', 06:45:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:47 INFO - 'PWD': '/builds/slave/test', 06:45:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:47 INFO - 'SHELL': '/bin/bash', 06:45:47 INFO - 'SHLVL': '1', 06:45:47 INFO - 'TERM': 'linux', 06:45:47 INFO - 'TMOUT': '86400', 06:45:47 INFO - 'USER': 'cltbld', 06:45:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015', 06:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:47 INFO - '_': '/tools/buildbot/bin/python'} 06:45:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:45:47 INFO - mozversion application_buildid: 20160714033529 06:45:47 INFO - mozversion application_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 06:45:47 INFO - mozversion application_display_name: Nightly 06:45:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:47 INFO - mozversion application_name: Firefox 06:45:47 INFO - mozversion application_remotingname: firefox 06:45:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:45:47 INFO - mozversion application_vendor: Mozilla 06:45:47 INFO - mozversion application_version: 50.0a1 06:45:47 INFO - mozversion platform_buildid: 20160714033529 06:45:47 INFO - mozversion platform_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 06:45:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:45:47 INFO - mozversion platform_version: 50.0a1 06:45:47 INFO - using testdate: 1468503947 06:45:47 INFO - actual date: 1468503947 06:45:47 INFO - starting webserver on 'localhost:36374' 06:45:47 INFO - SUITE-START | Running 2 tests 06:45:47 INFO - TEST-START | dromaeo_css 06:45:47 INFO - operating with platform_type : linux_ 06:45:47 INFO - Initialising browser for dromaeo_css test... 06:45:47 INFO - TEST-INFO | started process 16195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdi2feU/profile http://localhost:36374/getInfo.html) 06:45:52 INFO - PROCESS | 16195 | __metrics Screen width/height:1600/1200 06:45:52 INFO - PROCESS | 16195 | colorDepth:24 06:45:52 INFO - PROCESS | 16195 | Browser inner width/height: 1024/697 06:45:52 INFO - PROCESS | 16195 | __metrics 06:45:53 INFO - PROCESS | 16195 | 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" 06:45:53 INFO - PROCESS | 16195 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:53 INFO - PROCESS | 16195 | console.error: PushService: 06:45:53 INFO - PROCESS | 16195 | stateChangeProcessEnqueue: Error transitioning state 06:45:53 INFO - PROCESS | 16195 | UnknownError 06:45:54 INFO - TEST-INFO | 16195: exit 0 06:45:54 INFO - Browser initialized. 06:45:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:54 INFO - TEST-INFO | started process 16280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdi2feU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:05 INFO - PROCESS | 16280 | RSS: Main: 157442048 06:46:05 INFO - PROCESS | 16280 | 06:46:57 INFO - PROCESS | 16280 | 1468504017160 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] 06:49:05 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36374/tests/dromaeo/cssquery-ext.html) 06:49:06 INFO - PROCESS | 16280 | RSS: Main: 253902848 06:49:06 INFO - PROCESS | 16280 | 06:52:08 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-ext.html (next: http://localhost:36374/tests/dromaeo/cssquery-jquery.html) 06:52:09 INFO - PROCESS | 16280 | RSS: Main: 234139648 06:52:09 INFO - PROCESS | 16280 | 06:55:11 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36374/tests/dromaeo/cssquery-mootools.html) 06:55:11 INFO - PROCESS | 16280 | RSS: Main: 234315776 06:55:11 INFO - PROCESS | 16280 | 06:58:13 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36374/tests/dromaeo/cssquery-prototype.html) 06:58:14 INFO - PROCESS | 16280 | RSS: Main: 241172480 06:58:14 INFO - PROCESS | 16280 | 07:01:17 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36374/tests/dromaeo/cssquery-yui.html) 07:01:17 INFO - PROCESS | 16280 | RSS: Main: 227708928 07:01:17 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | Cycle 1(1): loaded http://localhost:36374/tests/dromaeo/cssquery-yui.html (next: http://localhost:36374/tests/dromaeo/cssquery-dojo.html) 07:04:20 INFO - PROCESS | 16280 | RSS: Main: 272433152 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | __start_tp_report 07:04:20 INFO - PROCESS | 16280 | _x_x_mozilla_page_load 07:04:20 INFO - PROCESS | 16280 | _x_x_mozilla_page_load_details 07:04:20 INFO - PROCESS | 16280 | |i|pagename|runs| 07:04:20 INFO - PROCESS | 16280 | |0;dojo.html;3023.274414140606;3053.9541906871414;3092.412441636089;3099.147734373047;3113.2061324362285;5230.79076836927;5307.814226502073;5385.784568617256;5484.506394424501;5504.80733174339;5325.733713314338;5366.302380690515;5383.650062745919;5389.622726409153;5401.864953376167;4747.762611869402;4809.326694262806;4866.805327786884;4876.268559716035;5049.24261360797;4935.777889994959;4947.653664243504;4990.575801056914;5013.147764879961;5016.021875734234;4779.928301075487;4833.154198015351;4840.128776820171;4845.781939812717;4847.418309802811;4826.469088400273;4844.031193761261;4896.265560165968;4897.240927656219;4949.455559888409;4848;4850.781714822841;4869;4872.220444728827;4932.383452068491;5311.867203319909;5374.328208973879;5424.213489044067;5501.752421141058;5524.33707955044;5814.767409303623;5825.1844741736195;5832.970835145839;5855.648661080349;5857.736401861884;5564.221009058735;5866.120081987693;5909.940900590982;5913.940860591425;5918.970405147989;5365.222042803772;5429.701366424845;5437.184422336642;5516.089845175501;5516.806911758069;6042.456178943916;6043;6043.244594425697;6048.002079656807;6053.970824959767;5453.590980676465;5593.720313984284;5685.602007859493;5706.914396284059;5711.971440142773;5722.198892155102;5819.6508209507565;5821.476067153892;5821.941780582225;5826.0678291474005;5695.373508914016;5743.10981797822;5745.626534275259;5746.367899531048;5810.767569297265;5579.4978451938705;5690.715464226772;5750.424957504216;5774.769009239667;5780.53755699543;4407.162639098561;4412.889677758082;4415.712978656377;4446.155230506258;4460.241758900995;3915.588863169326;3933.8229779659982;3937.291287568265;3954.6440820326306;3962.900927476836;5247.1866860636665;5305.681659100389;5429.782808687687;5444.482774136451;5486.149646804752;5855.414458554111;5869.148973398833;5872.354041055481;5884.293884733859;5914.02418600926;5535.7785688572;5542.3626282977975;5551.111822108443;5551.278333816578;5557.444255574491;4855.198892182821;4975.353204083518;5008.098542262428;5012.699238045729;5054.9241761373605;6033.5173186145;6044.486218671374;6048.546359023091;6049.425304596057;6050.606710563888;5802.912956305743;5839.299284085937;5843.7370318336625;5844.415558444121;5847.035239185657;5731.398203188605;5918.053111502139;5938.554608404474;5975.521958243243;6036.9698151508965;5657.915131272952;5700.657960522216;5711.828645140652;5713.1715901193265;5717.313922329347;5582.888342233214;5783.508401785727;5796.710164491674;5799.420057994167;5800.6809625471005;5441.564674826083;5581.49766521015;5626.774929002794;5678.659280443187;5680.062789639664;5614.466625670555;5656.23640808502;5661.85845353853;5664.235328230636;5664.348599911063;5364.624476286623;5522.337319521683;5598.21624972496;5604.355499117653;5610.85972850682;5674.687892165971;5725;5740.397258287987;5779.422057794355;5786;5569.972150139223;5605.719714014202;5610.382857885547;5616.66300022;5617.101263797773 07:04:20 INFO - PROCESS | 16280 | |1;ext.html;579.7796837201865;615.1388056720591;622.0327390907138;623.9563230573856;632.5603705424729;31786.523202151988;34083;34223.828880855595;42698.573014269845;43802.342964855554;44543;44809.77595112028;44898;44950.10099798002;44951;9097.81804363914;9248.398854074498;9248.445093294391;9258;9258.490783006931;9037.909620903773;9038.774030649221;9125.269978401746;9131.771705707377;9136.132067453582;8910.42082264654;8936.508492032935;8937.195652391283;8940.463572185658;8943.060978597252;9155.038720934273;9157.587908544065;9199.080091990814;9201.861972070425;9206.125418085272;9059.728208153765;9122.680706175319;9123;9125.041870603558;9129.406588571721;43187;43296.3505547417;43428.78285608583;43429.34855977163;43454.34818477726;3133.373325334919;3397.371486275022;3461.13471632092;3673.2286219893854;3693.4829123922673;32387.676123238703;32976.3404731904;33046;33262.50106248408;33721.83139084314;4411.867643970686;4514.119746649405;4569.817207311704;4597.494275629678;4603.332516785081;344334;344983;345682;346929;348013;57153.714231428574;57768;57814.42185578091;57847.421525785045;57907.131393029136;35258.47112293317;36289.092772680895;36362.27275454476;60423.39576604265;61134.38865611287;16670.499885003468;16809.41167059147;16838.83161168397;16858.24137913797;16880.240389182516;12913.514945781168;13063.34683265833;13088;13091.149075310264;13102.082854200115;19516.145966133194;19652.508687282647;19702.802971970097;19849.106790194186;19891.502712432306;7262.382697470668;7276.199618042011;7328.114872613117;7395.889061664079;7396.445266604918;985.8964808694984;1117.6535274065066;1144.2733863996423;1144.5193018931902;1189.1556994533978;32661.51007734886;32759.672403276138;32868;32893.17767055795;33316.83341583325;1119.4682525800342;1158.9826152607718;1165.516310731054;1167.7022359298326;1225.0950418980606;16977;17058.317667293417;17105.23026463812;17159.399421020204;17327.22027508765;157551;158116;158908;159349.203253983;159845;59102.40897591055;59600.70199648974;59731.402685972585;59773;59862;1240.057556257233;1281.372127657441;1334.873187047229;1381.0746799644262;1389.2359202438618;30929.536056958714;33543.66456335503;33854.322913542084;33919;34553.30893382068;48994.755026224644;49060.509394905595;49594;49621.503784961686;49631.503684962685;333664;333696;335097;335145;335561;25002;25050;27935.860320698266;28223;28272.85863570669;44229.55770442254;47359.76320118377;48281;48973;49522.25716614326;40646.59353406428;41511.37732933948;41517;41811;42001.579984199765;41318.38022429606;41591.792041039604;41738.373924391766;42245.36631950462;42636.147277053664;32728.67271327256;36247.45628815622;37280.44079338758;41439.37840932328;41805;30969.69030309758;36380.454293185096;36858.63141368552;37204;37213.813930931254;27904.30239244035;28035.158945231677;28305.57541636836;28455.900683053133;28467 07:04:20 INFO - PROCESS | 16280 | |2;jquery.html;357.4870061461801;378.59591593382027;386.1774420484368;386.70996752435667;399.57844474079855;15796.92101539492;18049.72925406118;18219.908900455514;19991.201231827556;20422.795772042275;16401.83598164018;16523.752143717822;16679.66640667186;16693.916530417362;20500.794992050112;5784.450477204669;5914.201582786333;5953.88092238155;5996.580239383245;5999.400059994009;5573.554115670757;5812.8837423251725;5849.473547380735;5857.6485410875275;5866.589338746289;5562.499375056244;5789.623674461168;5789.913151302734;5799.82600521985;5801.622894511865;5823.767049318022;5830.795922142725;5860.912086318709;5862.501687356558;5870.236869206997;4966.826161084345;5103.2855400244;5164.147915593922;5174.353205849269;5184.7148406837605;24033.51932961331;24038;24188.153414630404;24462.143824966217;24496.387590310384;2469.6542484052247;2513.0073620919634;2898.463784199909;2995.9400811983855;3231.789933654305;14564.126152430783;15231.314590843438;15267.465638702703;15281.541553753405;15323.923380383138;1786.214065811039;1807.8372946434752;1867.2437662746474;1906.2470324221993;1922.3464022232508;84688;88086.11913880843;89136;89310;91675;8851.159139881702;10031.548580313904;10585.89414105849;10598.205134614935;10660.307080039773;14654.63363415923;14775;14781.926090369694;14783.630409239855;14798.704025919636;7898.170692077249;8137.715179968673;8193.303569196565;8277.461964972257;8346.499210047417;7889.8816517752275;7979.082405523439;8150.470219435718;8154.592270386457;8174.959125204336;6537.150170477903;6611.272759996493;6631.436327912085;6668;6745.156855393076;1773.5034190426702;1794.2553840156188;1794.7038738607982;1811;1821.6812057889815;353.6269235956091;430.7609276851315;437.8467536362248;449.5976101389238;1027.5170669785189;11592.246503977214;12069.456874440672;12313.13808033429;12333.876661233273;12508.937455312665;468.9366935463737;475.2467339267231;477.1721063954037;480.64432320082886;486.0230935819029;6481.4166724994975;6599.7360105595235;6618.86762264752;6683.6324002180345;6750.628715420601;446659;447472;449118;491535;515229;80332.59833700793;98398;101665;102386.48806756067;102533.48733256286;466.94863565007824;473.3491449257271;473.5453964194343;475.02145580105093;476.0384024270953;11494.137939654393;11805.704857378634;11991.880081199426;12052.819207711716;12077.456514456695;43170.568294316654;43468.347974781034;43485.782571086944;43836.34245486256;44175.11649767051;59789.402105978384;60274;62973.68513157588;66152.66923665351;66355.33644663492;6858.314168583302;7888;8495.490270583785;8587.141285871612;8724.69463568772;13025.283609401575;13170.736585268049;13298.468061277441;13334.133281336683;14007.859921400655;5876;11344.24164254542;11843.23019003762;12168.695782605506;12187.817182742443;11393.373364465035;11788.528458861549;11845.822312665145;11865.822012669989;12077.39613019328;11002.284851484628;12140.33228172459;12271.202371845802;12457.750844983231;12738.172018818746;8461.661533538836;8809.031006589143;8897.021327654082;8925.330600204881;9104.908950910407;11483.655490335303;11518.424078796193;11549.42252887369;11576.768464630492;12352.197107188003 07:04:20 INFO - PROCESS | 16280 | |3;mootools.html;1463.6487243061665;1474.159728954496;1624.42332971795;1775.112443778111;1804.0258260539301;8376.62305196266;8912.64349426022;8960.507172105532;9008.729738107852;9009.144131307523;7662;8398.454100483465;8617.353698472623;8650.394472386919;8812.162844529776;2395.6765836612053;2421.4309637235237;2426.817988650849;2428.429319110008;2428.574999375111;2398.388410955204;2417.9758202417925;2439.609662454008;2441.7924476419525;2447.1801946347905;2005.3181918147827;2281.9201327953524;2357.986065991623;2359.5634807560655;2371.5731168389684;2379.250536081146;2394.3415560720855;2403.2189538399916;2411.9517609647796;2419.758024197584;2348.131191459154;2375.8336916415856;2378.9048438062628;2379.8215133864855;2380.8928598213124;9004.549772511347;9043.819123617557;9057.230135438496;9060.864087038699;9061.456312621198;5122.231665250242;5244.318238628954;5250.081235783722;5257.342832145981;5258.710770907599;3332.900012999614;3442.845071971742;3457.896263112111;3486.930261394758;3495.353359628477;1081.2809481694665;1098.3739268616891;1114.9597871170063;1119.8096323625002;1123.1688550472672;12657.493700251978;12663.683407914783;12674.873251267461;12685.936570317182;12695.111342205957;4720.693154944917;4779.814611899216;4864.82973095947;4916;4997.475265097185;10542.367457952547;10544.051035406697;10574.154067674568;10634.680959571226;10765.192610554239;5539.806106786243;5567.693776842231;5581.832545023574;5592.384837667853;5597.8600534986135;5047.848564543069;5114.079465696211;5127.128388174019;5173.63784535079;5185.792568297301;4118.238125946709;4162.310181727657;4199.958000420018;4236.152769446123;4247.235497610398;1156.2022204678744;1180.7520420711576;1293.2369901758009;1331.8801307882336;1343.2880573296168;804.8130197337713;934.2105920497169;996.875390576178;1009.2884516416055;1015.7816069544936;6152.569320147636;6193.163922870445;6198.752049918043;6342;6354.3010268870385;967.8644989701447;981.4601968917067;987.916027137687;988.4514094677379;1013.8732658417698;4028.879133625996;4168;4220.767857767791;4286.314189729628;4317.330813723878;11119.888801112047;11485.368304743319;11558.942205289088;11576;11592.246503977214;10970.506327215295;11211.60759373418;11435.142364322543;11443.198976071595;11444.427778611036;8198.754037378889;8245.13426090264;8284.544350060683;8325;8354.28988535969;6050.213472248755;6195.132681424514;6236.532260080603;6246.812595622138;6441.87166917483;10266.845997309896;10459.895401045893;10528.157747380345;10642.467876606293;10692.946535267274;10664.253502254767;10744.818070012449;10756.784864302826;10833.187510936554;10879.510422031186;7655.88516172269;7698;7767.223277672188;7780.572068536285;7782.844343113219;8348.791280218044;8363.665453381796;8433.325333973391;8433.536155511505;8544.615492302737;5679.716014199356;7529.284717951786;7633.732819351296;7745.070591529053;7841.647125879464;7399.852002960019;7551.471397002157;7635.694572217049;7650.846983060419;7733.265339792711;7094.148702155774;7147.82130446743;7199.172095208908;7213.747518836815;7217.278272172741;5341.62608617393;5366.087765080024;5406.864828379322;5465.754041068241;5556.055470569932;5242.18746094356;5433.8369848904595;5493.285872836505;5539.362973258127;5581.74882130297 07:04:20 INFO - PROCESS | 16280 | |4;prototype.html;330.84781000739656;332.2060275940503;338.7053263660615;340.98636054557835;343.2089034774846;5449.337951924661;5478.150886612571;5488.835334939953;5500.944990550093;5534.75093620787;5369.62412631115;5371.597130215239;5451.972740136303;5470.152126420401;5470.425605311435;3983.9402408963815;4065.2479291331197;4197.874063778077;4199.433076534675;4216.831326746927;4157.482518880602;4170.39529268256;4188.267053265681;4194.78351278129;4205.978970105145;3917.921641567167;4149.481314835645;4173.56177601352;4196.916061678765;4204.654510556623;3989.561148273702;4004.1991601679633;4105.8973525661795;4130;4153.709240353177;3646.8541258349633;3668.834902429397;3669.8256557901213;3685.834137463794;3697.4453831925157;5208.5051920067535;5219.399769026572;5232.136697444917;5237.685738855681;5296.788128474856;4635;4737.128834110542;4746.311784791221;4753.928691069636;4782.928256076161;5556.194351819004;5565.693886836222;5578.553715702734;5624.578156638268;5626.493615574618;4013.9397909031386;4020.9396859047138;4033.193361327746;4033.3546632538655;4035.4148648446103;5645.689487078209;5816.534677225812;5822.951868663639;5827.504662103726;5837.09525023622;4010.7393019453643;4026.516817981861;4032.0927791247323;4033.798310084484;4037.7173597848455;4153.065560248981;4177.206330797199;4179.728317659343;4182.163567286555;4194.538600753915;4595.494495605481;4733.857984260478;4736.19484687597;4737.526247375304;4774.761261936889;5594.3286805582775;5598.748056337393;5609.663420194802;5609.971950140223;5620.241267428926;1411.2802470739996;1424.8290205175444;1427.8572142785638;1431.4059665239017;1432.1192466633154;914.9588268527932;917.9541022948825;936.5691781780457;964.2816102003911;976.3897564022486;5375.059364611177;5382.838514844561;5423.322084739408;5437.184422336682;5442.2380866678695;5744.51171650406;5752.539796816244;5795.246617939641;5800.622959507618;5825.300963884276;5126.53861152498;5310.867228319323;5330.866728331745;5349.438308977579;5415.918761218585;3033.2416895776055;3037.817730936151;3064.9233769155503;3066.1874603230162;3068.7544996400234;5694.402087780723;5918.99377105893;5922.733476993546;5944.216734979489;5974.223350964434;5939.881202375928;5949.464548190684;5954.910676339859;5958.76164953397;6000;5960.523158147338;5966.0454327307425;5994.430529099728;6022.909656355246;6076.848078798065;5607.5513958882375;5770.394108618702;5775.191473193672;5776.8555786104;5873.295204575478;5726;5733.369329373849;5748.166515855094;5762;5769.442250592233;5846.883062338815;5941.554383421174;5969.940300597113;5996.640201587918;6045.304789949037;4065.329220678555;4073.5519092899162;4095.610916962884;4099.323611604052;4101.26177288091;5557.610967232255;5617.691026993554;5766.308043034863;5769.249997500298;5804.361520232686;5652.689102099424;5678.3186017678145;5684.759686978383;5691.8861622768145;5697.173909783141;5661.433856614306;5696.401877802771;5708.686022268649;5720.3707592164;5750.856228594319;5533.446655334435;5614.747336369955;5619.719014049363;5623.831285061455;5630.0991841305195;5681;5701.515371193329;5724.141378793214;5742.5405967521665;5760.308762948473;5387.164989426645;5547.195656629686;5594.4125866785025;5624.493795558419;5645.4072322405555 07:04:20 INFO - PROCESS | 16280 | |5;yui.html;743.561298833688;757.3940847322141;765.4985984180361;769.2807225244397;836.7322456813822;14863.851361486382;14881.702365952675;14893.478728244514;16181.433649822258;16473.176341182938;12147;12165.14843960921;12185.817212741817;12193.878061219386;12243.938780306085;791.4064451661269;808.5552945879742;811.1726039439768;812.0215140755375;813.7151996801132;671.684308375063;791.1376599506536;806.5241507510567;809.8623234050197;811.7077851973285;862.374778285741;863.2187869977649;864.9524276164808;865.2904618213067;866.2074202105066;858.6393714639804;858.9570521473902;859.3597769661611;859.7506723050308;859.9484030958131;508.64903216780306;610.6092101055328;623.9500839932795;625.9499240060784;630.4011189370071;14674.926625366805;14745.410183592643;14774.55676329701;14791.630209244748;14844.332005059798;13528.25594592297;13901.860981390158;13982.650433739136;13994.16035037901;14252.786208206886;11728.35494047827;12043.397830108459;12579;12631.557895473707;12648.620541383772;4577.542245775396;4628.352030715702;4636.582707556302;4645.837395691135;4791.3531673224015;72816;73995.26004739938;74496.62751686262;78947.63157105239;79494.20505794926;12327;12336.938315308365;12353.38233088342;12390.194637348544;12557.309347985765;21846.781532184792;21928;22022.33932982013;22031.118755249932;22283;8104.27061564462;8283.964504436944;8432.012354596955;8435.072142064368;8546.700865469678;4752.881177970578;4760.833370832073;4793.304970779218;4811.687240329437;4980.676256043418;3570.589382221026;3660.176460296412;3663.9450408243897;3881.165549406891;4061.898452538651;654.1006116589689;655.4199533412964;658.7595527632476;664.1963224498314;675.3853992866468;504.70222568684653;540.4487422828693;584.6638183044766;609.338867328953;634.3592971099131;8621.870671939925;9031.50326732036;9054.502002389932;9199.908000919904;9380.108889655472;583.7985894866264;666.4302021771413;671.5769065488809;689.3451221339748;711.8006958051753;4204.1291625227095;4237.491501019897;4339.067100573392;4385.583369579885;4543.1822271990695;104787;110183.44908275567;113572.43213784043;113604.43197783959;114417;97044;97309.51345243228;98054.5097274509;99660;99923.50038249762;85058.14941850503;86938;87247.76513409216;87640;87804.5609771947;8678.739637810875;8752.868706969273;8938.910610893809;9105.271578273854;9120.680776172801;47506.52493475159;48726.512734872194;49631;50658.74670626623;50829;66273.66863165653;66637.66681166564;73956.63021684857;76536.61731691306;76550.6172469134;10896.673099807018;11777.175597708077;11876.406179691154;12024.218425802295;12238.388080595756;12370.381480926098;12774.808377874153;13141.54004609834;13795.448182073007;13858.722825543635;11008.834867476835;11032.227744057838;11281.661550153509;11302;11764.411779411166;11989;12037;12217.389130543615;12295.87704122983;12487.188332758342;11807.940960295144;12168.148229623841;12281.877181228074;12333.876661233631;13767.449302027806;11127.777444451227;11719.41402929833;11743.17797754149;11923.165378423428;11956.940215298868;11029.172812038969;11229.66311010671;11705.590304339306;11742.17804753659;11878.040123379546 07:04:20 INFO - PROCESS | 16280 | __end_tp_report 07:04:20 INFO - PROCESS | 16280 | __start_cc_report 07:04:20 INFO - PROCESS | 16280 | _x_x_mozilla_cycle_collect,834 07:04:20 INFO - PROCESS | 16280 | __end_cc_report 07:04:20 INFO - PROCESS | 16280 | __startTimestamp1468505060578__endTimestamp 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | ------- Summary: start ------- 07:04:20 INFO - PROCESS | 16280 | Number of tests: 6 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#0] dojo.html Cycles:165 Average:5373.23 Median:5581.50 stddev:628.05 (11.3%) stddev-sans-first:602.31 07:04:20 INFO - PROCESS | 16280 | Values: 3023.3 3054.0 3092.4 3099.1 3113.2 5230.8 5307.8 5385.8 5484.5 5504.8 5325.7 5366.3 5383.7 5389.6 5401.9 4747.8 4809.3 4866.8 4876.3 5049.2 4935.8 4947.7 4990.6 5013.1 5016.0 4779.9 4833.2 4840.1 4845.8 4847.4 4826.5 4844.0 4896.3 4897.2 4949.5 4848.0 4850.8 4869.0 4872.2 4932.4 5311.9 5374.3 5424.2 5501.8 5524.3 5814.8 5825.2 5833.0 5855.6 5857.7 5564.2 5866.1 5909.9 5913.9 5919.0 5365.2 5429.7 5437.2 5516.1 5516.8 6042.5 6043.0 6043.2 6048.0 6054.0 5453.6 5593.7 5685.6 5706.9 5712.0 5722.2 5819.7 5821.5 5821.9 5826.1 5695.4 5743.1 5745.6 5746.4 5810.8 5579.5 5690.7 5750.4 5774.8 5780.5 4407.2 4412.9 4415.7 4446.2 4460.2 3915.6 3933.8 3937.3 3954.6 3962.9 5247.2 5305.7 5429.8 5444.5 5486.1 5855.4 5869.1 5872.4 5884.3 5914.0 5535.8 5542.4 5551.1 5551.3 5557.4 4855.2 4975.4 5008.1 5012.7 5054.9 6033.5 6044.5 6048.5 6049.4 6050.6 5802.9 5839.3 5843.7 5844.4 5847.0 5731.4 5918.1 5938.6 5975.5 6037.0 5657.9 5700.7 5711.8 5713.2 5717.3 5582.9 5783.5 5796.7 5799.4 5800.7 5441.6 5581.5 5626.8 5678.7 5680.1 5614.5 5656.2 5661.9 5664.2 5664.3 5364.6 5522.3 5598.2 5604.4 5610.9 5674.7 5725.0 5740.4 5779.4 5786.0 5570.0 5605.7 5610.4 5616.7 5617.1 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#1] ext.html Cycles:180 Average:46346.20 Median:37208.91 stddev:76842.14 (206.5%) stddev-sans-first:76980.87 07:04:20 INFO - PROCESS | 16280 | Values: 579.8 615.1 622.0 624.0 632.6 31786.5 34083.0 34223.8 42698.6 43802.3 44543.0 44809.8 44898.0 44950.1 44951.0 9097.8 9248.4 9248.4 9258.0 9258.5 9037.9 9038.8 9125.3 9131.8 9136.1 8910.4 8936.5 8937.2 8940.5 8943.1 9155.0 9157.6 9199.1 9201.9 9206.1 9059.7 9122.7 9123.0 9125.0 9129.4 43187.0 43296.4 43428.8 43429.3 43454.3 3133.4 3397.4 3461.1 3673.2 3693.5 32387.7 32976.3 33046.0 33262.5 33721.8 4411.9 4514.1 4569.8 4597.5 4603.3 344334.0 344983.0 345682.0 346929.0 348013.0 57153.7 57768.0 57814.4 57847.4 57907.1 35258.5 36289.1 36362.3 60423.4 61134.4 16670.5 16809.4 16838.8 16858.2 16880.2 12913.5 13063.3 13088.0 13091.1 13102.1 19516.1 19652.5 19702.8 19849.1 19891.5 7262.4 7276.2 7328.1 7395.9 7396.4 985.9 1117.7 1144.3 1144.5 1189.2 32661.5 32759.7 32868.0 32893.2 33316.8 1119.5 1159.0 1165.5 1167.7 1225.1 16977.0 17058.3 17105.2 17159.4 17327.2 157551.0 158116.0 158908.0 159349.2 159845.0 59102.4 59600.7 59731.4 59773.0 59862.0 1240.1 1281.4 1334.9 1381.1 1389.2 30929.5 33543.7 33854.3 33919.0 34553.3 48994.8 49060.5 49594.0 49621.5 49631.5 333664.0 333696.0 335097.0 335145.0 335561.0 25002.0 25050.0 27935.9 28223.0 28272.9 44229.6 47359.8 48281.0 48973.0 49522.3 40646.6 41511.4 41517.0 41811.0 42001.6 41318.4 41591.8 41738.4 42245.4 42636.1 32728.7 36247.5 37280.4 41439.4 41805.0 30969.7 36380.5 36858.6 37204.0 37213.8 27904.3 28035.2 28305.6 28455.9 28467.0 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#2] jquery.html Cycles:180 Average:28596.55 Median:43477.07 stddev:78185.06 (179.8%) stddev-sans-first:78375.64 07:04:20 INFO - PROCESS | 16280 | Values: 357.5 378.6 386.2 386.7 399.6 15796.9 18049.7 18219.9 19991.2 20422.8 16401.8 16523.8 16679.7 16693.9 20500.8 5784.5 5914.2 5953.9 5996.6 5999.4 5573.6 5812.9 5849.5 5857.6 5866.6 5562.5 5789.6 5789.9 5799.8 5801.6 5823.8 5830.8 5860.9 5862.5 5870.2 4966.8 5103.3 5164.1 5174.4 5184.7 24033.5 24038.0 24188.2 24462.1 24496.4 2469.7 2513.0 2898.5 2995.9 3231.8 14564.1 15231.3 15267.5 15281.5 15323.9 1786.2 1807.8 1867.2 1906.2 1922.3 84688.0 88086.1 89136.0 89310.0 91675.0 8851.2 10031.5 10585.9 10598.2 10660.3 14654.6 14775.0 14781.9 14783.6 14798.7 7898.2 8137.7 8193.3 8277.5 8346.5 7889.9 7979.1 8150.5 8154.6 8175.0 6537.2 6611.3 6631.4 6668.0 6745.2 1773.5 1794.3 1794.7 1811.0 1821.7 353.6 430.8 437.8 449.6 1027.5 11592.2 12069.5 12313.1 12333.9 12508.9 468.9 475.2 477.2 480.6 486.0 6481.4 6599.7 6618.9 6683.6 6750.6 446659.0 447472.0 449118.0 491535.0 515229.0 80332.6 98398.0 101665.0 102386.5 102533.5 466.9 473.3 473.5 475.0 476.0 11494.1 11805.7 11991.9 12052.8 12077.5 43170.6 43468.3 43485.8 43836.3 44175.1 59789.4 60274.0 62973.7 66152.7 66355.3 6858.3 7888.0 8495.5 8587.1 8724.7 13025.3 13170.7 13298.5 13334.1 14007.9 5876.0 11344.2 11843.2 12168.7 12187.8 11393.4 11788.5 11845.8 11865.8 12077.4 11002.3 12140.3 12271.2 12457.8 12738.2 8461.7 8809.0 8897.0 8925.3 9104.9 11483.7 11518.4 11549.4 11576.8 12352.2 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#3] mootools.html Cycles:180 Average:5944.59 Median:4890.41 stddev:3381.32 (69.1%) stddev-sans-first:3374.03 07:04:20 INFO - PROCESS | 16280 | Values: 1463.6 1474.2 1624.4 1775.1 1804.0 8376.6 8912.6 8960.5 9008.7 9009.1 7662.0 8398.5 8617.4 8650.4 8812.2 2395.7 2421.4 2426.8 2428.4 2428.6 2398.4 2418.0 2439.6 2441.8 2447.2 2005.3 2281.9 2358.0 2359.6 2371.6 2379.3 2394.3 2403.2 2412.0 2419.8 2348.1 2375.8 2378.9 2379.8 2380.9 9004.5 9043.8 9057.2 9060.9 9061.5 5122.2 5244.3 5250.1 5257.3 5258.7 3332.9 3442.8 3457.9 3486.9 3495.4 1081.3 1098.4 1115.0 1119.8 1123.2 12657.5 12663.7 12674.9 12685.9 12695.1 4720.7 4779.8 4864.8 4916.0 4997.5 10542.4 10544.1 10574.2 10634.7 10765.2 5539.8 5567.7 5581.8 5592.4 5597.9 5047.8 5114.1 5127.1 5173.6 5185.8 4118.2 4162.3 4200.0 4236.2 4247.2 1156.2 1180.8 1293.2 1331.9 1343.3 804.8 934.2 996.9 1009.3 1015.8 6152.6 6193.2 6198.8 6342.0 6354.3 967.9 981.5 987.9 988.5 1013.9 4028.9 4168.0 4220.8 4286.3 4317.3 11119.9 11485.4 11558.9 11576.0 11592.2 10970.5 11211.6 11435.1 11443.2 11444.4 8198.8 8245.1 8284.5 8325.0 8354.3 6050.2 6195.1 6236.5 6246.8 6441.9 10266.8 10459.9 10528.2 10642.5 10692.9 10664.3 10744.8 10756.8 10833.2 10879.5 7655.9 7698.0 7767.2 7780.6 7782.8 8348.8 8363.7 8433.3 8433.5 8544.6 5679.7 7529.3 7633.7 7745.1 7841.6 7399.9 7551.5 7635.7 7650.8 7733.3 7094.1 7147.8 7199.2 7213.7 7217.3 5341.6 5366.1 5406.9 5465.8 5556.1 5242.2 5433.8 5493.3 5539.4 5581.7 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#4] prototype.html Cycles:180 Average:4740.77 Median:5470.29 stddev:1407.65 (25.7%) stddev-sans-first:1372.13 07:04:20 INFO - PROCESS | 16280 | Values: 330.8 332.2 338.7 341.0 343.2 5449.3 5478.2 5488.8 5500.9 5534.8 5369.6 5371.6 5452.0 5470.2 5470.4 3983.9 4065.2 4197.9 4199.4 4216.8 4157.5 4170.4 4188.3 4194.8 4206.0 3917.9 4149.5 4173.6 4196.9 4204.7 3989.6 4004.2 4105.9 4130.0 4153.7 3646.9 3668.8 3669.8 3685.8 3697.4 5208.5 5219.4 5232.1 5237.7 5296.8 4635.0 4737.1 4746.3 4753.9 4782.9 5556.2 5565.7 5578.6 5624.6 5626.5 4013.9 4020.9 4033.2 4033.4 4035.4 5645.7 5816.5 5823.0 5827.5 5837.1 4010.7 4026.5 4032.1 4033.8 4037.7 4153.1 4177.2 4179.7 4182.2 4194.5 4595.5 4733.9 4736.2 4737.5 4774.8 5594.3 5598.7 5609.7 5610.0 5620.2 1411.3 1424.8 1427.9 1431.4 1432.1 915.0 918.0 936.6 964.3 976.4 5375.1 5382.8 5423.3 5437.2 5442.2 5744.5 5752.5 5795.2 5800.6 5825.3 5126.5 5310.9 5330.9 5349.4 5415.9 3033.2 3037.8 3064.9 3066.2 3068.8 5694.4 5919.0 5922.7 5944.2 5974.2 5939.9 5949.5 5954.9 5958.8 6000.0 5960.5 5966.0 5994.4 6022.9 6076.8 5607.6 5770.4 5775.2 5776.9 5873.3 5726.0 5733.4 5748.2 5762.0 5769.4 5846.9 5941.6 5969.9 5996.6 6045.3 4065.3 4073.6 4095.6 4099.3 4101.3 5557.6 5617.7 5766.3 5769.2 5804.4 5652.7 5678.3 5684.8 5691.9 5697.2 5661.4 5696.4 5708.7 5720.4 5750.9 5533.4 5614.7 5619.7 5623.8 5630.1 5681.0 5701.5 5724.1 5742.5 5760.3 5387.2 5547.2 5594.4 5624.5 5645.4 07:04:20 INFO - PROCESS | 16280 | 07:04:20 INFO - PROCESS | 16280 | [#5] yui.html Cycles:180 Average:20326.93 Median:4756.86 stddev:29483.61 (619.8%) stddev-sans-first:29529.65 07:04:20 INFO - PROCESS | 16280 | Values: 743.6 757.4 765.5 769.3 836.7 14863.9 14881.7 14893.5 16181.4 16473.2 12147.0 12165.1 12185.8 12193.9 12243.9 791.4 808.6 811.2 812.0 813.7 671.7 791.1 806.5 809.9 811.7 862.4 863.2 865.0 865.3 866.2 858.6 859.0 859.4 859.8 859.9 508.6 610.6 624.0 625.9 630.4 14674.9 14745.4 14774.6 14791.6 14844.3 13528.3 13901.9 13982.7 13994.2 14252.8 11728.4 12043.4 12579.0 12631.6 12648.6 4577.5 4628.4 4636.6 4645.8 4791.4 72816.0 73995.3 74496.6 78947.6 79494.2 12327.0 12336.9 12353.4 12390.2 12557.3 21846.8 21928.0 22022.3 22031.1 22283.0 8104.3 8284.0 8432.0 8435.1 8546.7 4752.9 4760.8 4793.3 4811.7 4980.7 3570.6 3660.2 3663.9 3881.2 4061.9 654.1 655.4 658.8 664.2 675.4 504.7 540.4 584.7 609.3 634.4 8621.9 9031.5 9054.5 9199.9 9380.1 583.8 666.4 671.6 689.3 711.8 4204.1 4237.5 4339.1 4385.6 4543.2 104787.0 110183.4 113572.4 113604.4 114417.0 97044.0 97309.5 98054.5 99660.0 99923.5 85058.1 86938.0 87247.8 87640.0 87804.6 8678.7 8752.9 8938.9 9105.3 9120.7 47506.5 48726.5 49631.0 50658.7 50829.0 66273.7 66637.7 73956.6 76536.6 76550.6 10896.7 11777.2 11876.4 12024.2 12238.4 12370.4 12774.8 13141.5 13795.4 13858.7 11008.8 11032.2 11281.7 11302.0 11764.4 11989.0 12037.0 12217.4 12295.9 12487.2 11807.9 12168.1 12281.9 12333.9 13767.4 11127.8 11719.4 11743.2 11923.2 11956.9 11029.2 11229.7 11705.6 11742.2 11878.0 07:04:20 INFO - PROCESS | 16280 | -------- Summary: end -------- 07:04:20 INFO - PROCESS | 16280 | 07:04:21 INFO - TEST-INFO | 16280: exit 0 07:04:21 INFO - TEST-OK | dromaeo_css | took 1113604ms 07:04:21 INFO - TEST-START | kraken 07:04:21 INFO - operating with platform_type : linux_ 07:04:21 INFO - Initialising browser for kraken test... 07:04:21 INFO - TEST-INFO | started process 16470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpozwD96/profile http://localhost:36374/getInfo.html) 07:04:25 INFO - PROCESS | 16470 | __metrics Screen width/height:1600/1200 07:04:25 INFO - PROCESS | 16470 | colorDepth:24 07:04:25 INFO - PROCESS | 16470 | Browser inner width/height: 1024/697 07:04:25 INFO - PROCESS | 16470 | __metrics 07:04:26 INFO - PROCESS | 16470 | 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" 07:04:26 INFO - PROCESS | 16470 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:04:27 INFO - TEST-INFO | 16470: exit 0 07:04:27 INFO - Browser initialized. 07:04:27 INFO - Running cycle 1/1 for kraken test... 07:04:27 INFO - TEST-INFO | started process 16554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpozwD96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:39 INFO - PROCESS | 16554 | RSS: Main: 157671424 07:04:39 INFO - PROCESS | 16554 | 07:04:41 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:42 INFO - PROCESS | 16554 | RSS: Main: 215900160 07:04:42 INFO - PROCESS | 16554 | 07:04:45 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-dft) 07:04:45 INFO - PROCESS | 16554 | RSS: Main: 202801152 07:04:45 INFO - PROCESS | 16554 | 07:04:49 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-fft) 07:04:49 INFO - PROCESS | 16554 | RSS: Main: 270409728 07:04:49 INFO - PROCESS | 16554 | 07:04:51 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36374/tests/kraken/driver.html?testName=audio-oscillator) 07:04:52 INFO - PROCESS | 16554 | RSS: Main: 180379648 07:04:52 INFO - PROCESS | 16554 | 07:04:54 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:55 INFO - PROCESS | 16554 | RSS: Main: 184856576 07:04:55 INFO - PROCESS | 16554 | 07:04:58 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:58 INFO - PROCESS | 16554 | RSS: Main: 219717632 07:04:58 INFO - PROCESS | 16554 | 07:05:02 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36374/tests/kraken/driver.html?testName=imaging-desaturate) 07:05:02 INFO - PROCESS | 16554 | RSS: Main: 221302784 07:05:02 INFO - PROCESS | 16554 | 07:05:05 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36374/tests/kraken/driver.html?testName=json-parse-financial) 07:05:06 INFO - PROCESS | 16554 | RSS: Main: 221593600 07:05:06 INFO - PROCESS | 16554 | 07:05:07 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:05:08 INFO - PROCESS | 16554 | RSS: Main: 206848000 07:05:08 INFO - PROCESS | 16554 | 07:05:09 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:05:10 INFO - PROCESS | 16554 | RSS: Main: 212832256 07:05:10 INFO - PROCESS | 16554 | 07:05:12 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:05:13 INFO - PROCESS | 16554 | RSS: Main: 211402752 07:05:13 INFO - PROCESS | 16554 | 07:05:15 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:05:16 INFO - PROCESS | 16554 | RSS: Main: 223735808 07:05:16 INFO - PROCESS | 16554 | 07:05:18 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:05:19 INFO - PROCESS | 16554 | RSS: Main: 225636352 07:05:19 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | Cycle 1(1): loaded http://localhost:36374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36374/tests/kraken/driver.html?testName=ai-astar) 07:05:21 INFO - PROCESS | 16554 | RSS: Main: 267636736 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | __start_tp_report 07:05:21 INFO - PROCESS | 16554 | _x_x_mozilla_page_load 07:05:21 INFO - PROCESS | 16554 | _x_x_mozilla_page_load_details 07:05:21 INFO - PROCESS | 16554 | |i|pagename|runs| 07:05:21 INFO - PROCESS | 16554 | |0;ai-astar;103;113;113;112;113;111;111;112;111;111 07:05:21 INFO - PROCESS | 16554 | |1;audio-beat-detection;138;115;117;175;117;122;140;116;173;117 07:05:21 INFO - PROCESS | 16554 | |2;audio-dft;162;161;160;160;160;161;161;162;160;160 07:05:21 INFO - PROCESS | 16554 | |3;audio-fft;74;74;75;111;75;77;74;75;106;76 07:05:21 INFO - PROCESS | 16554 | |4;audio-oscillator;84;83;115;83;83;84;127;82;84;126 07:05:21 INFO - PROCESS | 16554 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;117 07:05:21 INFO - PROCESS | 16554 | |6;imaging-darkroom;146;146;146;145;145;146;145;146;145;146 07:05:21 INFO - PROCESS | 16554 | |7;imaging-desaturate;95;94;95;94;95;95;95;94;95;95 07:05:21 INFO - PROCESS | 16554 | |8;json-parse-financial;51;53;54;52;52;53;52;52;54;52 07:05:21 INFO - PROCESS | 16554 | |9;json-stringify-tinderbox;62;63;63;62;62;62;62;63;62;62 07:05:21 INFO - PROCESS | 16554 | |10;stanford-crypto-aes;75;75;79;80;74;74;73;74;74;84 07:05:21 INFO - PROCESS | 16554 | |11;stanford-crypto-ccm;127;116;120;126;116;118;116;118;194;126 07:05:21 INFO - PROCESS | 16554 | |12;stanford-crypto-pbkdf2;165;158;153;155;155;154;155;152;153;152 07:05:21 INFO - PROCESS | 16554 | |13;stanford-crypto-sha256-iterative;65;63;64;62;65;61;61;60;60;65 07:05:21 INFO - PROCESS | 16554 | __end_tp_report 07:05:21 INFO - PROCESS | 16554 | __start_cc_report 07:05:21 INFO - PROCESS | 16554 | _x_x_mozilla_cycle_collect,1662 07:05:21 INFO - PROCESS | 16554 | __end_cc_report 07:05:21 INFO - PROCESS | 16554 | __startTimestamp1468505121418__endTimestamp 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | ------- Summary: start ------- 07:05:21 INFO - PROCESS | 16554 | Number of tests: 14 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 07:05:21 INFO - PROCESS | 16554 | Values: 103.0 113.0 113.0 112.0 113.0 111.0 111.0 112.0 111.0 111.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:130.00 stddev:23.43 (18.0%) stddev-sans-first:24.78 07:05:21 INFO - PROCESS | 16554 | Values: 138.0 115.0 117.0 175.0 117.0 122.0 140.0 116.0 173.0 117.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 07:05:21 INFO - PROCESS | 16554 | Values: 162.0 161.0 160.0 160.0 160.0 161.0 161.0 162.0 160.0 160.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:14.21 (18.9%) stddev-sans-first:14.79 07:05:21 INFO - PROCESS | 16554 | Values: 74.0 74.0 75.0 111.0 75.0 77.0 74.0 75.0 106.0 76.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:19.29 (23.2%) stddev-sans-first:20.04 07:05:21 INFO - PROCESS | 16554 | Values: 84.0 83.0 115.0 83.0 83.0 84.0 127.0 82.0 84.0 126.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:05:21 INFO - PROCESS | 16554 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:05:21 INFO - PROCESS | 16554 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:05:21 INFO - PROCESS | 16554 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:0.97 (1.9%) stddev-sans-first:0.87 07:05:21 INFO - PROCESS | 16554 | Values: 51.0 53.0 54.0 52.0 52.0 53.0 52.0 52.0 54.0 52.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:05:21 INFO - PROCESS | 16554 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:3.58 (4.8%) stddev-sans-first:3.77 07:05:21 INFO - PROCESS | 16554 | Values: 75.0 75.0 79.0 80.0 74.0 74.0 73.0 74.0 74.0 84.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:123.00 stddev:23.71 (19.3%) stddev-sans-first:25.15 07:05:21 INFO - PROCESS | 16554 | Values: 127.0 116.0 120.0 126.0 116.0 118.0 116.0 118.0 194.0 126.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.00 stddev:3.88 (2.5%) stddev-sans-first:1.90 07:05:21 INFO - PROCESS | 16554 | Values: 165.0 158.0 153.0 155.0 155.0 154.0 155.0 152.0 153.0 152.0 07:05:21 INFO - PROCESS | 16554 | 07:05:21 INFO - PROCESS | 16554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.50 stddev:2.07 (3.3%) stddev-sans-first:2.00 07:05:21 INFO - PROCESS | 16554 | Values: 65.0 63.0 64.0 62.0 65.0 61.0 61.0 60.0 60.0 65.0 07:05:21 INFO - PROCESS | 16554 | -------- Summary: end -------- 07:05:21 INFO - PROCESS | 16554 | 07:05:22 INFO - TEST-INFO | 16554: exit 0 07:05:22 INFO - TEST-OK | kraken | took 61104ms 07:05:22 INFO - SUITE-END | took 1174s 07:05:22 INFO - Completed test suite (00:19:34) 07:05:22 INFO - javascript benchmark 07:05:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3023.274414140606, 3053.9541906871414, 3092.412441636089, 3099.147734373047, 3113.2061324362285, 5230.79076836927, 5307.814226502073, 5385.784568617256, 5484.506394424501, 5504.80733174339, 5325.733713314338, 5366.302380690515, 5383.650062745919, 5389.622726409153, 5401.864953376167, 4747.762611869402, 4809.326694262806, 4866.805327786884, 4876.268559716035, 5049.24261360797, 4935.777889994959, 4947.653664243504, 4990.575801056914, 5013.147764879961, 5016.021875734234, 4779.928301075487, 4833.154198015351, 4840.128776820171, 4845.781939812717, 4847.418309802811, 4826.469088400273, 4844.031193761261, 4896.265560165968, 4897.240927656219, 4949.455559888409, 4848.0, 4850.781714822841, 4869.0, 4872.220444728827, 4932.383452068491, 5311.867203319909, 5374.328208973879, 5424.213489044067, 5501.752421141058, 5524.33707955044, 5814.767409303623, 5825.1844741736195, 5832.970835145839, 5855.648661080349, 5857.736401861884, 5564.221009058735, 5866.120081987693, 5909.940900590982, 5913.940860591425, 5918.970405147989, 5365.222042803772, 5429.701366424845, 5437.184422336642, 5516.089845175501, 5516.806911758069, 6042.456178943916, 6043.0, 6043.244594425697, 6048.002079656807, 6053.970824959767, 5453.590980676465, 5593.720313984284, 5685.602007859493, 5706.914396284059, 5711.971440142773, 5722.198892155102, 5819.6508209507565, 5821.476067153892, 5821.941780582225, 5826.0678291474005, 5695.373508914016, 5743.10981797822, 5745.626534275259, 5746.367899531048, 5810.767569297265, 5579.4978451938705, 5690.715464226772, 5750.424957504216, 5774.769009239667, 5780.53755699543, 4407.162639098561, 4412.889677758082, 4415.712978656377, 4446.155230506258, 4460.241758900995, 3915.588863169326, 3933.8229779659982, 3937.291287568265, 3954.6440820326306, 3962.900927476836, 5247.1866860636665, 5305.681659100389, 5429.782808687687, 5444.482774136451, 5486.149646804752, 5855.414458554111, 5869.148973398833, 5872.354041055481, 5884.293884733859, 5914.02418600926, 5535.7785688572, 5542.3626282977975, 5551.111822108443, 5551.278333816578, 5557.444255574491, 4855.198892182821, 4975.353204083518, 5008.098542262428, 5012.699238045729, 5054.9241761373605, 6033.5173186145, 6044.486218671374, 6048.546359023091, 6049.425304596057, 6050.606710563888, 5802.912956305743, 5839.299284085937, 5843.7370318336625, 5844.415558444121, 5847.035239185657, 5731.398203188605, 5918.053111502139, 5938.554608404474, 5975.521958243243, 6036.9698151508965, 5657.915131272952, 5700.657960522216, 5711.828645140652, 5713.1715901193265, 5717.313922329347, 5582.888342233214, 5783.508401785727, 5796.710164491674, 5799.420057994167, 5800.6809625471005, 5441.564674826083, 5581.49766521015, 5626.774929002794, 5678.659280443187, 5680.062789639664, 5614.466625670555, 5656.23640808502, 5661.85845353853, 5664.235328230636, 5664.348599911063, 5364.624476286623, 5522.337319521683, 5598.21624972496, 5604.355499117653, 5610.85972850682, 5674.687892165971, 5725.0, 5740.397258287987, 5779.422057794355, 5786.0, 5569.972150139223, 5605.719714014202, 5610.382857885547, 5616.66300022, 5617.101263797773], "value": 5329.60416602681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7796837201865, 615.1388056720591, 622.0327390907138, 623.9563230573856, 632.5603705424729, 31786.523202151988, 34083.0, 34223.828880855595, 42698.573014269845, 43802.342964855554, 44543.0, 44809.77595112028, 44898.0, 44950.10099798002, 44951.0, 9097.81804363914, 9248.398854074498, 9248.445093294391, 9258.0, 9258.490783006931, 9037.909620903773, 9038.774030649221, 9125.269978401746, 9131.771705707377, 9136.132067453582, 8910.42082264654, 8936.508492032935, 8937.195652391283, 8940.463572185658, 8943.060978597252, 9155.038720934273, 9157.587908544065, 9199.080091990814, 9201.861972070425, 9206.125418085272, 9059.728208153765, 9122.680706175319, 9123.0, 9125.041870603558, 9129.406588571721, 43187.0, 43296.3505547417, 43428.78285608583, 43429.34855977163, 43454.34818477726, 3133.373325334919, 3397.371486275022, 3461.13471632092, 3673.2286219893854, 3693.4829123922673, 32387.676123238703, 32976.3404731904, 33046.0, 33262.50106248408, 33721.83139084314, 4411.867643970686, 4514.119746649405, 4569.817207311704, 4597.494275629678, 4603.332516785081, 344334.0, 344983.0, 345682.0, 346929.0, 348013.0, 57153.714231428574, 57768.0, 57814.42185578091, 57847.421525785045, 57907.131393029136, 35258.47112293317, 36289.092772680895, 36362.27275454476, 60423.39576604265, 61134.38865611287, 16670.499885003468, 16809.41167059147, 16838.83161168397, 16858.24137913797, 16880.240389182516, 12913.514945781168, 13063.34683265833, 13088.0, 13091.149075310264, 13102.082854200115, 19516.145966133194, 19652.508687282647, 19702.802971970097, 19849.106790194186, 19891.502712432306, 7262.382697470668, 7276.199618042011, 7328.114872613117, 7395.889061664079, 7396.445266604918, 985.8964808694984, 1117.6535274065066, 1144.2733863996423, 1144.5193018931902, 1189.1556994533978, 32661.51007734886, 32759.672403276138, 32868.0, 32893.17767055795, 33316.83341583325, 1119.4682525800342, 1158.9826152607718, 1165.516310731054, 1167.7022359298326, 1225.0950418980606, 16977.0, 17058.317667293417, 17105.23026463812, 17159.399421020204, 17327.22027508765, 157551.0, 158116.0, 158908.0, 159349.203253983, 159845.0, 59102.40897591055, 59600.70199648974, 59731.402685972585, 59773.0, 59862.0, 1240.057556257233, 1281.372127657441, 1334.873187047229, 1381.0746799644262, 1389.2359202438618, 30929.536056958714, 33543.66456335503, 33854.322913542084, 33919.0, 34553.30893382068, 48994.755026224644, 49060.509394905595, 49594.0, 49621.503784961686, 49631.503684962685, 333664.0, 333696.0, 335097.0, 335145.0, 335561.0, 25002.0, 25050.0, 27935.860320698266, 28223.0, 28272.85863570669, 44229.55770442254, 47359.76320118377, 48281.0, 48973.0, 49522.25716614326, 40646.59353406428, 41511.37732933948, 41517.0, 41811.0, 42001.579984199765, 41318.38022429606, 41591.792041039604, 41738.373924391766, 42245.36631950462, 42636.147277053664, 32728.67271327256, 36247.45628815622, 37280.44079338758, 41439.37840932328, 41805.0, 30969.69030309758, 36380.454293185096, 36858.63141368552, 37204.0, 37213.813930931254, 27904.30239244035, 28035.158945231677, 28305.57541636836, 28455.900683053133, 28467.0], "value": 19281.431665056163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.4870061461801, 378.59591593382027, 386.1774420484368, 386.70996752435667, 399.57844474079855, 15796.92101539492, 18049.72925406118, 18219.908900455514, 19991.201231827556, 20422.795772042275, 16401.83598164018, 16523.752143717822, 16679.66640667186, 16693.916530417362, 20500.794992050112, 5784.450477204669, 5914.201582786333, 5953.88092238155, 5996.580239383245, 5999.400059994009, 5573.554115670757, 5812.8837423251725, 5849.473547380735, 5857.6485410875275, 5866.589338746289, 5562.499375056244, 5789.623674461168, 5789.913151302734, 5799.82600521985, 5801.622894511865, 5823.767049318022, 5830.795922142725, 5860.912086318709, 5862.501687356558, 5870.236869206997, 4966.826161084345, 5103.2855400244, 5164.147915593922, 5174.353205849269, 5184.7148406837605, 24033.51932961331, 24038.0, 24188.153414630404, 24462.143824966217, 24496.387590310384, 2469.6542484052247, 2513.0073620919634, 2898.463784199909, 2995.9400811983855, 3231.789933654305, 14564.126152430783, 15231.314590843438, 15267.465638702703, 15281.541553753405, 15323.923380383138, 1786.214065811039, 1807.8372946434752, 1867.2437662746474, 1906.2470324221993, 1922.3464022232508, 84688.0, 88086.11913880843, 89136.0, 89310.0, 91675.0, 8851.159139881702, 10031.548580313904, 10585.89414105849, 10598.205134614935, 10660.307080039773, 14654.63363415923, 14775.0, 14781.926090369694, 14783.630409239855, 14798.704025919636, 7898.170692077249, 8137.715179968673, 8193.303569196565, 8277.461964972257, 8346.499210047417, 7889.8816517752275, 7979.082405523439, 8150.470219435718, 8154.592270386457, 8174.959125204336, 6537.150170477903, 6611.272759996493, 6631.436327912085, 6668.0, 6745.156855393076, 1773.5034190426702, 1794.2553840156188, 1794.7038738607982, 1811.0, 1821.6812057889815, 353.6269235956091, 430.7609276851315, 437.8467536362248, 449.5976101389238, 1027.5170669785189, 11592.246503977214, 12069.456874440672, 12313.13808033429, 12333.876661233273, 12508.937455312665, 468.9366935463737, 475.2467339267231, 477.1721063954037, 480.64432320082886, 486.0230935819029, 6481.4166724994975, 6599.7360105595235, 6618.86762264752, 6683.6324002180345, 6750.628715420601, 446659.0, 447472.0, 449118.0, 491535.0, 515229.0, 80332.59833700793, 98398.0, 101665.0, 102386.48806756067, 102533.48733256286, 466.94863565007824, 473.3491449257271, 473.5453964194343, 475.02145580105093, 476.0384024270953, 11494.137939654393, 11805.704857378634, 11991.880081199426, 12052.819207711716, 12077.456514456695, 43170.568294316654, 43468.347974781034, 43485.782571086944, 43836.34245486256, 44175.11649767051, 59789.402105978384, 60274.0, 62973.68513157588, 66152.66923665351, 66355.33644663492, 6858.314168583302, 7888.0, 8495.490270583785, 8587.141285871612, 8724.69463568772, 13025.283609401575, 13170.736585268049, 13298.468061277441, 13334.133281336683, 14007.859921400655, 5876.0, 11344.24164254542, 11843.23019003762, 12168.695782605506, 12187.817182742443, 11393.373364465035, 11788.528458861549, 11845.822312665145, 11865.822012669989, 12077.39613019328, 11002.284851484628, 12140.33228172459, 12271.202371845802, 12457.750844983231, 12738.172018818746, 8461.661533538836, 8809.031006589143, 8897.021327654082, 8925.330600204881, 9104.908950910407, 11483.655490335303, 11518.424078796193, 11549.42252887369, 11576.768464630492, 12352.197107188003], "value": 8558.826445091372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.6487243061665, 1474.159728954496, 1624.42332971795, 1775.112443778111, 1804.0258260539301, 8376.62305196266, 8912.64349426022, 8960.507172105532, 9008.729738107852, 9009.144131307523, 7662.0, 8398.454100483465, 8617.353698472623, 8650.394472386919, 8812.162844529776, 2395.6765836612053, 2421.4309637235237, 2426.817988650849, 2428.429319110008, 2428.574999375111, 2398.388410955204, 2417.9758202417925, 2439.609662454008, 2441.7924476419525, 2447.1801946347905, 2005.3181918147827, 2281.9201327953524, 2357.986065991623, 2359.5634807560655, 2371.5731168389684, 2379.250536081146, 2394.3415560720855, 2403.2189538399916, 2411.9517609647796, 2419.758024197584, 2348.131191459154, 2375.8336916415856, 2378.9048438062628, 2379.8215133864855, 2380.8928598213124, 9004.549772511347, 9043.819123617557, 9057.230135438496, 9060.864087038699, 9061.456312621198, 5122.231665250242, 5244.318238628954, 5250.081235783722, 5257.342832145981, 5258.710770907599, 3332.900012999614, 3442.845071971742, 3457.896263112111, 3486.930261394758, 3495.353359628477, 1081.2809481694665, 1098.3739268616891, 1114.9597871170063, 1119.8096323625002, 1123.1688550472672, 12657.493700251978, 12663.683407914783, 12674.873251267461, 12685.936570317182, 12695.111342205957, 4720.693154944917, 4779.814611899216, 4864.82973095947, 4916.0, 4997.475265097185, 10542.367457952547, 10544.051035406697, 10574.154067674568, 10634.680959571226, 10765.192610554239, 5539.806106786243, 5567.693776842231, 5581.832545023574, 5592.384837667853, 5597.8600534986135, 5047.848564543069, 5114.079465696211, 5127.128388174019, 5173.63784535079, 5185.792568297301, 4118.238125946709, 4162.310181727657, 4199.958000420018, 4236.152769446123, 4247.235497610398, 1156.2022204678744, 1180.7520420711576, 1293.2369901758009, 1331.8801307882336, 1343.2880573296168, 804.8130197337713, 934.2105920497169, 996.875390576178, 1009.2884516416055, 1015.7816069544936, 6152.569320147636, 6193.163922870445, 6198.752049918043, 6342.0, 6354.3010268870385, 967.8644989701447, 981.4601968917067, 987.916027137687, 988.4514094677379, 1013.8732658417698, 4028.879133625996, 4168.0, 4220.767857767791, 4286.314189729628, 4317.330813723878, 11119.888801112047, 11485.368304743319, 11558.942205289088, 11576.0, 11592.246503977214, 10970.506327215295, 11211.60759373418, 11435.142364322543, 11443.198976071595, 11444.427778611036, 8198.754037378889, 8245.13426090264, 8284.544350060683, 8325.0, 8354.28988535969, 6050.213472248755, 6195.132681424514, 6236.532260080603, 6246.812595622138, 6441.87166917483, 10266.845997309896, 10459.895401045893, 10528.157747380345, 10642.467876606293, 10692.946535267274, 10664.253502254767, 10744.818070012449, 10756.784864302826, 10833.187510936554, 10879.510422031186, 7655.88516172269, 7698.0, 7767.223277672188, 7780.572068536285, 7782.844343113219, 8348.791280218044, 8363.665453381796, 8433.325333973391, 8433.536155511505, 8544.615492302737, 5679.716014199356, 7529.284717951786, 7633.732819351296, 7745.070591529053, 7841.647125879464, 7399.852002960019, 7551.471397002157, 7635.694572217049, 7650.846983060419, 7733.265339792711, 7094.148702155774, 7147.82130446743, 7199.172095208908, 7213.747518836815, 7217.278272172741, 5341.62608617393, 5366.087765080024, 5406.864828379322, 5465.754041068241, 5556.055470569932, 5242.18746094356, 5433.8369848904595, 5493.285872836505, 5539.362973258127, 5581.74882130297], "value": 4754.473718558281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.84781000739656, 332.2060275940503, 338.7053263660615, 340.98636054557835, 343.2089034774846, 5449.337951924661, 5478.150886612571, 5488.835334939953, 5500.944990550093, 5534.75093620787, 5369.62412631115, 5371.597130215239, 5451.972740136303, 5470.152126420401, 5470.425605311435, 3983.9402408963815, 4065.2479291331197, 4197.874063778077, 4199.433076534675, 4216.831326746927, 4157.482518880602, 4170.39529268256, 4188.267053265681, 4194.78351278129, 4205.978970105145, 3917.921641567167, 4149.481314835645, 4173.56177601352, 4196.916061678765, 4204.654510556623, 3989.561148273702, 4004.1991601679633, 4105.8973525661795, 4130.0, 4153.709240353177, 3646.8541258349633, 3668.834902429397, 3669.8256557901213, 3685.834137463794, 3697.4453831925157, 5208.5051920067535, 5219.399769026572, 5232.136697444917, 5237.685738855681, 5296.788128474856, 4635.0, 4737.128834110542, 4746.311784791221, 4753.928691069636, 4782.928256076161, 5556.194351819004, 5565.693886836222, 5578.553715702734, 5624.578156638268, 5626.493615574618, 4013.9397909031386, 4020.9396859047138, 4033.193361327746, 4033.3546632538655, 4035.4148648446103, 5645.689487078209, 5816.534677225812, 5822.951868663639, 5827.504662103726, 5837.09525023622, 4010.7393019453643, 4026.516817981861, 4032.0927791247323, 4033.798310084484, 4037.7173597848455, 4153.065560248981, 4177.206330797199, 4179.728317659343, 4182.163567286555, 4194.538600753915, 4595.494495605481, 4733.857984260478, 4736.19484687597, 4737.526247375304, 4774.761261936889, 5594.3286805582775, 5598.748056337393, 5609.663420194802, 5609.971950140223, 5620.241267428926, 1411.2802470739996, 1424.8290205175444, 1427.8572142785638, 1431.4059665239017, 1432.1192466633154, 914.9588268527932, 917.9541022948825, 936.5691781780457, 964.2816102003911, 976.3897564022486, 5375.059364611177, 5382.838514844561, 5423.322084739408, 5437.184422336682, 5442.2380866678695, 5744.51171650406, 5752.539796816244, 5795.246617939641, 5800.622959507618, 5825.300963884276, 5126.53861152498, 5310.867228319323, 5330.866728331745, 5349.438308977579, 5415.918761218585, 3033.2416895776055, 3037.817730936151, 3064.9233769155503, 3066.1874603230162, 3068.7544996400234, 5694.402087780723, 5918.99377105893, 5922.733476993546, 5944.216734979489, 5974.223350964434, 5939.881202375928, 5949.464548190684, 5954.910676339859, 5958.76164953397, 6000.0, 5960.523158147338, 5966.0454327307425, 5994.430529099728, 6022.909656355246, 6076.848078798065, 5607.5513958882375, 5770.394108618702, 5775.191473193672, 5776.8555786104, 5873.295204575478, 5726.0, 5733.369329373849, 5748.166515855094, 5762.0, 5769.442250592233, 5846.883062338815, 5941.554383421174, 5969.940300597113, 5996.640201587918, 6045.304789949037, 4065.329220678555, 4073.5519092899162, 4095.610916962884, 4099.323611604052, 4101.26177288091, 5557.610967232255, 5617.691026993554, 5766.308043034863, 5769.249997500298, 5804.361520232686, 5652.689102099424, 5678.3186017678145, 5684.759686978383, 5691.8861622768145, 5697.173909783141, 5661.433856614306, 5696.401877802771, 5708.686022268649, 5720.3707592164, 5750.856228594319, 5533.446655334435, 5614.747336369955, 5619.719014049363, 5623.831285061455, 5630.0991841305195, 5681.0, 5701.515371193329, 5724.141378793214, 5742.5405967521665, 5760.308762948473, 5387.164989426645, 5547.195656629686, 5594.4125866785025, 5624.493795558419, 5645.4072322405555], "value": 4290.929141471948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.561298833688, 757.3940847322141, 765.4985984180361, 769.2807225244397, 836.7322456813822, 14863.851361486382, 14881.702365952675, 14893.478728244514, 16181.433649822258, 16473.176341182938, 12147.0, 12165.14843960921, 12185.817212741817, 12193.878061219386, 12243.938780306085, 791.4064451661269, 808.5552945879742, 811.1726039439768, 812.0215140755375, 813.7151996801132, 671.684308375063, 791.1376599506536, 806.5241507510567, 809.8623234050197, 811.7077851973285, 862.374778285741, 863.2187869977649, 864.9524276164808, 865.2904618213067, 866.2074202105066, 858.6393714639804, 858.9570521473902, 859.3597769661611, 859.7506723050308, 859.9484030958131, 508.64903216780306, 610.6092101055328, 623.9500839932795, 625.9499240060784, 630.4011189370071, 14674.926625366805, 14745.410183592643, 14774.55676329701, 14791.630209244748, 14844.332005059798, 13528.25594592297, 13901.860981390158, 13982.650433739136, 13994.16035037901, 14252.786208206886, 11728.35494047827, 12043.397830108459, 12579.0, 12631.557895473707, 12648.620541383772, 4577.542245775396, 4628.352030715702, 4636.582707556302, 4645.837395691135, 4791.3531673224015, 72816.0, 73995.26004739938, 74496.62751686262, 78947.63157105239, 79494.20505794926, 12327.0, 12336.938315308365, 12353.38233088342, 12390.194637348544, 12557.309347985765, 21846.781532184792, 21928.0, 22022.33932982013, 22031.118755249932, 22283.0, 8104.27061564462, 8283.964504436944, 8432.012354596955, 8435.072142064368, 8546.700865469678, 4752.881177970578, 4760.833370832073, 4793.304970779218, 4811.687240329437, 4980.676256043418, 3570.589382221026, 3660.176460296412, 3663.9450408243897, 3881.165549406891, 4061.898452538651, 654.1006116589689, 655.4199533412964, 658.7595527632476, 664.1963224498314, 675.3853992866468, 504.70222568684653, 540.4487422828693, 584.6638183044766, 609.338867328953, 634.3592971099131, 8621.870671939925, 9031.50326732036, 9054.502002389932, 9199.908000919904, 9380.108889655472, 583.7985894866264, 666.4302021771413, 671.5769065488809, 689.3451221339748, 711.8006958051753, 4204.1291625227095, 4237.491501019897, 4339.067100573392, 4385.583369579885, 4543.1822271990695, 104787.0, 110183.44908275567, 113572.43213784043, 113604.43197783959, 114417.0, 97044.0, 97309.51345243228, 98054.5097274509, 99660.0, 99923.50038249762, 85058.14941850503, 86938.0, 87247.76513409216, 87640.0, 87804.5609771947, 8678.739637810875, 8752.868706969273, 8938.910610893809, 9105.271578273854, 9120.680776172801, 47506.52493475159, 48726.512734872194, 49631.0, 50658.74670626623, 50829.0, 66273.66863165653, 66637.66681166564, 73956.63021684857, 76536.61731691306, 76550.6172469134, 10896.673099807018, 11777.175597708077, 11876.406179691154, 12024.218425802295, 12238.388080595756, 12370.381480926098, 12774.808377874153, 13141.54004609834, 13795.448182073007, 13858.722825543635, 11008.834867476835, 11032.227744057838, 11281.661550153509, 11302.0, 11764.411779411166, 11989.0, 12037.0, 12217.389130543615, 12295.87704122983, 12487.188332758342, 11807.940960295144, 12168.148229623841, 12281.877181228074, 12333.876661233631, 13767.449302027806, 11127.777444451227, 11719.41402929833, 11743.17797754149, 11923.165378423428, 11956.940215298868, 11029.172812038969, 11229.66311010671, 11705.590304339306, 11742.17804753659, 11878.040123379546], "value": 7365.015642366833, "unit": "score"}], "name": "dromaeo_css", "value": 7137.062726983306, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 112.0, 113.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 115.0, 117.0, 175.0, 117.0, 122.0, 140.0, 116.0, 173.0, 117.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 111.0, 75.0, 77.0, 74.0, 75.0, 106.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 83.0, 83.0, 84.0, 127.0, 82.0, 84.0, 126.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 54.0, 52.0, 52.0, 53.0, 52.0, 52.0, 54.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 80.0, 74.0, 74.0, 73.0, 74.0, 74.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 120.0, 126.0, 116.0, 118.0, 116.0, 118.0, 194.0, 126.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 158.0, 153.0, 155.0, 155.0, 154.0, 155.0, 152.0, 153.0, 152.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 62.0, 65.0, 61.0, 61.0, 60.0, 60.0, 65.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1475.5000000000002, "alertThreshold": 2.0}]} 07:05:22 INFO - Return code: 0 07:05:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:05:22 INFO - # TBPL SUCCESS # 07:05:22 INFO - Running post-action listener: _resource_record_post_action 07:05:22 INFO - ##### 07:05:22 INFO - ##### Finished run-tests step (success) 07:05:22 INFO - ##### 07:05:22 INFO - Running post-run listener: _resource_record_post_run 07:05:22 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 147456; Write bytes: 568385536; Read time: 44; Write time: 1003028 07:05:22 INFO - TinderboxPrint: CPU usage
13.0% 07:05:22 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 44 07:05:22 INFO - TinderboxPrint: I/O write bytes / time
568,385,536 / 1,003,028 07:05:22 INFO - TinderboxPrint: CPU idle
8,273.2 (87.0%) 07:05:22 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 07:05:22 INFO - TinderboxPrint: Swap in / out
0 / 0 07:05:22 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 273682432; Read time: 0; Write time: 647144 07:05:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 143360; Write bytes: 294703104; Read time: 32; Write time: 355884 07:05:23 INFO - Running post-run listener: _upload_blobber_files 07:05:23 INFO - Blob upload gear active. 07:05:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:05:23 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 07:05:23 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:05:23 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:05:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:28 INFO - (blobuploader) - INFO - Done attempting. 07:05:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:05:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:05:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:29 INFO - (blobuploader) - INFO - Done attempting. 07:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:05:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:30 INFO - (blobuploader) - INFO - Done attempting. 07:05:30 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:30 INFO - Return code: 0 07:05:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/260da3f61342a1d786aa578188cdec4b1dbb2c78cbda5e49c5f2aa66488c4a3a97cc0c9de8ee813b2b6f14d0672e3432dece195a7249fb4379bdbedfaf2412b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a1f9efd65b23426fbecb528f7fc3b34c0d0027047b544b62649e62a6d2f09936df3a1ff3d056cd13199877c8327f8d8da12bdb4e121095c657a28610ee200", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d00cf33bf598e0bbc9fb6f01290a877755a850ce79ba079e5b2db037d593aa7b5ccf7e241adaad6dddfbfe97e111617ec9aab99c56f740a77074fa768f7a1391"} 07:05:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:30 INFO - Contents: 07:05:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/260da3f61342a1d786aa578188cdec4b1dbb2c78cbda5e49c5f2aa66488c4a3a97cc0c9de8ee813b2b6f14d0672e3432dece195a7249fb4379bdbedfaf2412b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a1f9efd65b23426fbecb528f7fc3b34c0d0027047b544b62649e62a6d2f09936df3a1ff3d056cd13199877c8327f8d8da12bdb4e121095c657a28610ee200", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d00cf33bf598e0bbc9fb6f01290a877755a850ce79ba079e5b2db037d593aa7b5ccf7e241adaad6dddfbfe97e111617ec9aab99c56f740a77074fa768f7a1391"} 07:05:30 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:30 INFO - Copying logs to upload dir... 07:05:30 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.070729 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-14 07:05:30.440450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:05:30.444221) ========= 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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 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/sha512/260da3f61342a1d786aa578188cdec4b1dbb2c78cbda5e49c5f2aa66488c4a3a97cc0c9de8ee813b2b6f14d0672e3432dece195a7249fb4379bdbedfaf2412b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a1f9efd65b23426fbecb528f7fc3b34c0d0027047b544b62649e62a6d2f09936df3a1ff3d056cd13199877c8327f8d8da12bdb4e121095c657a28610ee200", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d00cf33bf598e0bbc9fb6f01290a877755a850ce79ba079e5b2db037d593aa7b5ccf7e241adaad6dddfbfe97e111617ec9aab99c56f740a77074fa768f7a1391"} build_url:https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/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/sha512/260da3f61342a1d786aa578188cdec4b1dbb2c78cbda5e49c5f2aa66488c4a3a97cc0c9de8ee813b2b6f14d0672e3432dece195a7249fb4379bdbedfaf2412b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a1f9efd65b23426fbecb528f7fc3b34c0d0027047b544b62649e62a6d2f09936df3a1ff3d056cd13199877c8327f8d8da12bdb4e121095c657a28610ee200", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d00cf33bf598e0bbc9fb6f01290a877755a850ce79ba079e5b2db037d593aa7b5ccf7e241adaad6dddfbfe97e111617ec9aab99c56f740a77074fa768f7a1391"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:05:30.471662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:05:30.472162) ========= 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=af724c981e2a0f424dbabf99000001e7-1468503889.237410-1019675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:05:30.555377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:05:30.555701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:05:30.555988) ========= ========= Total master_lag: 0.32 =========