builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1468844390.7 results: success (0) buildid: 20160718023044 builduid: 129cbaccaa354d5aabc322f22abe817a revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.697427) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.697929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.698204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.712457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.712728) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:19:50-- 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% 212M=0s 2016-07-18 05:19:51 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087392 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.814303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.814619) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.865443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:50.865877) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc547f508f58108db8b9ad9c2b94f130c07de194 --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 bc547f508f58108db8b9ad9c2b94f130c07de194 --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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:19:51,189 truncating revision to first 12 chars 2016-07-18 05:19:51,189 Setting DEBUG logging. 2016-07-18 05:19:51,189 attempt 1/10 2016-07-18 05:19:51,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc547f508f58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:19:51,495 unpacking tar archive at: fx-team-bc547f508f58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648907 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:51.528752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:51.529086) ========= script_repo_revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:51.529488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:51.529818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:19:51.541227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-18 05:19:51.541510) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:51 INFO - MultiFileLogger online at 20160718 05:19:51 in /builds/slave/test 05:19:51 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 05:19:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:51 INFO - {'append_to_log': False, 05:19:51 INFO - 'base_work_dir': '/builds/slave/test', 05:19:51 INFO - 'blob_upload_branch': 'Fx-Team', 05:19:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:51 INFO - 'branch': 'Fx-Team', 05:19:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:51 INFO - 'config_files': ('talos/linux_config.py',), 05:19:51 INFO - 'default_actions': ('clobber', 05:19:51 INFO - 'read-buildbot-config', 05:19:51 INFO - 'download-and-extract', 05:19:51 INFO - 'populate-webroot', 05:19:51 INFO - 'create-virtualenv', 05:19:51 INFO - 'install', 05:19:51 INFO - 'run-tests'), 05:19:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:51 INFO - 'download_minidump_stackwalk': True, 05:19:51 INFO - 'download_symbols': 'ondemand', 05:19:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:51 INFO - 'installer_path': 'installer.exe', 05:19:51 INFO - 'log_level': 'info', 05:19:51 INFO - 'log_name': 'talos', 05:19:51 INFO - 'log_to_console': True, 05:19:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:51 INFO - 'opt_config_files': (), 05:19:51 INFO - 'pip_index': False, 05:19:51 INFO - 'sps_profile': False, 05:19:51 INFO - 'sps_profile_interval': 0, 05:19:51 INFO - 'suite': 'dromaeojs', 05:19:51 INFO - 'system_bits': '32', 05:19:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:51 INFO - 'title': 'talos-linux64-ix-037', 05:19:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:51 INFO - 'use_talos_json': True, 05:19:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:51 INFO - 'work_dir': 'build'} 05:19:51 INFO - ##### 05:19:51 INFO - ##### Running clobber step. 05:19:51 INFO - ##### 05:19:51 INFO - Running pre-action listener: _resource_record_pre_action 05:19:51 INFO - Running main action method: clobber 05:19:51 INFO - rmtree: /builds/slave/test/build 05:19:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:52 INFO - Running post-action listener: _resource_record_post_action 05:19:52 INFO - ##### 05:19:52 INFO - ##### Finished clobber step (success) 05:19:52 INFO - ##### 05:19:52 INFO - ##### 05:19:52 INFO - ##### Running read-buildbot-config step. 05:19:52 INFO - ##### 05:19:52 INFO - Running pre-action listener: _resource_record_pre_action 05:19:52 INFO - Running main action method: read_buildbot_config 05:19:52 INFO - Using buildbot properties: 05:19:52 INFO - { 05:19:52 INFO - "project": "", 05:19:52 INFO - "product": "firefox", 05:19:52 INFO - "script_repo_revision": "production", 05:19:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:19:52 INFO - "repository": "", 05:19:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:19:52 INFO - "buildid": "20160718023044", 05:19:52 INFO - "pgo_build": "True", 05:19:52 INFO - "basedir": "/builds/slave/test", 05:19:52 INFO - "buildnumber": 908, 05:19:52 INFO - "slavename": "talos-linux64-ix-037", 05:19:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:19:52 INFO - "platform": "ubuntu64_hw", 05:19:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:19:52 INFO - "branch": "fx-team", 05:19:52 INFO - "repo_path": "integration/fx-team", 05:19:52 INFO - "revision": "bc547f508f58108db8b9ad9c2b94f130c07de194", 05:19:52 INFO - "stage_platform": "linux64-pgo", 05:19:52 INFO - "builduid": "129cbaccaa354d5aabc322f22abe817a", 05:19:52 INFO - "slavebuilddir": "test" 05:19:52 INFO - } 05:19:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:19:52 INFO - Running post-action listener: _resource_record_post_action 05:19:52 INFO - ##### 05:19:52 INFO - ##### Finished read-buildbot-config step (success) 05:19:52 INFO - ##### 05:19:52 INFO - ##### 05:19:52 INFO - ##### Running download-and-extract step. 05:19:52 INFO - ##### 05:19:52 INFO - Running pre-action listener: _resource_record_pre_action 05:19:52 INFO - Running main action method: download_and_extract 05:19:52 INFO - mkdir: /builds/slave/test/build/tests 05:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:52 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:19:53 INFO - Downloaded 1361 bytes. 05:19:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:53 INFO - Using the following test package requirements: 05:19:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:19:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:19:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'jsshell-linux-x86_64.zip'], 05:19:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:19:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:19:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:19:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:19:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:19:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:53 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:19:54 INFO - Downloaded 24334234 bytes. 05:19:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:19:55 INFO - Return code: 0 05:19:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:55 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:19:56 INFO - Downloaded 24334234 bytes. 05:19:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:19:58 INFO - Return code: 0 05:19: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')]} 05:19:58 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:19:59 INFO - Downloaded 14403317 bytes. 05:19:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:19:59 INFO - Return code: 0 05:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:59 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:00 INFO - Downloaded 60818167 bytes. 05:20:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:00 INFO - mkdir: /builds/slave/test/properties 05:20:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:00 INFO - Contents: 05:20:00 INFO - build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:01 INFO - Running post-action listener: _resource_record_post_action 05:20:01 INFO - Running post-action listener: set_extra_try_arguments 05:20:01 INFO - ##### 05:20:01 INFO - ##### Finished download-and-extract step (success) 05:20:01 INFO - ##### 05:20:01 INFO - ##### 05:20:01 INFO - ##### Running populate-webroot step. 05:20:01 INFO - ##### 05:20:01 INFO - Running pre-action listener: _resource_record_pre_action 05:20:01 INFO - Running main action method: populate_webroot 05:20:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:01 INFO - '--tppagecycles', 05:20:01 INFO - '7'], 05:20:01 INFO - 'tests': ['tsvgm']}}, 05:20:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['damp', 'tps']}, 05:20:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'tests': ['damp', 'tps']}, 05:20:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['dromaeo_dom']}, 05:20:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['basic_compositor_video']}, 05:20:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:20:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['a11yr', 05:20:01 INFO - 'ts_paint', 05:20:01 INFO - 'tpaint', 05:20:01 INFO - 'sessionrestore', 05:20:01 INFO - 'sessionrestore_no_auto_restore', 05:20:01 INFO - 'tabpaint']}, 05:20:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['tsvgx', 05:20:01 INFO - 'tsvgr_opacity', 05:20:01 INFO - 'tart', 05:20:01 INFO - 'tscrollx', 05:20:01 INFO - 'cart']}, 05:20:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:01 INFO - 'tsvgr_opacity', 05:20:01 INFO - 'tart', 05:20:01 INFO - 'tscrollx', 05:20:01 INFO - 'cart']}, 05:20:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'talos_options': ['--disable-e10s'], 05:20:01 INFO - 'tests': ['tp5o']}, 05:20:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'tests': ['tp5o']}, 05:20:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'talos_options': ['--disable-e10s', 05:20:01 INFO - '--xperf_path', 05:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:01 INFO - 'tests': ['tp5n']}, 05:20:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:01 INFO - 'talos_options': ['--xperf_path', 05:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:01 INFO - 'tests': ['tp5n']}}, 05:20:01 INFO - 'talos.zip': {'path': '', 05:20:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:01 INFO - Running post-action listener: _resource_record_post_action 05:20:01 INFO - ##### 05:20:01 INFO - ##### Finished populate-webroot step (success) 05:20:01 INFO - ##### 05:20:01 INFO - ##### 05:20:01 INFO - ##### Running create-virtualenv step. 05:20:01 INFO - ##### 05:20:01 INFO - Running pre-action listener: _resource_record_pre_action 05:20:01 INFO - Running main action method: create_virtualenv 05:20:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:20:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:01 INFO - Using real prefix '/usr' 05:20:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:03 INFO - Installing pip.................done. 05:20:04 INFO - Return code: 0 05:20:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:04 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:04 INFO - Using env: {'DISPLAY': ':0', 05:20:04 INFO - 'HOME': '/home/cltbld', 05:20:04 INFO - 'LANG': 'en_US.UTF-8', 05:20:04 INFO - 'LANGUAGE': 'en_US:en', 05:20:04 INFO - 'LOGNAME': 'cltbld', 05:20:04 INFO - 'MAIL': '/var/mail/cltbld', 05:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:04 INFO - 'MOZ_NO_REMOTE': '1', 05:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:04 INFO - 'NO_EM_RESTART': '1', 05:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:04 INFO - 'PWD': '/builds/slave/test', 05:20:04 INFO - 'SHELL': '/bin/bash', 05:20:04 INFO - 'SHLVL': '1', 05:20:04 INFO - 'TERM': 'linux', 05:20:04 INFO - 'TMOUT': '86400', 05:20:04 INFO - 'USER': 'cltbld', 05:20:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:04 INFO - '_': '/tools/buildbot/bin/python'} 05:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:20:04 INFO - Cleaning up... 05:20:04 INFO - Return code: 0 05:20:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:04 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:20:04 INFO - Using env: {'DISPLAY': ':0', 05:20:04 INFO - 'HOME': '/home/cltbld', 05:20:04 INFO - 'LANG': 'en_US.UTF-8', 05:20:04 INFO - 'LANGUAGE': 'en_US:en', 05:20:04 INFO - 'LOGNAME': 'cltbld', 05:20:04 INFO - 'MAIL': '/var/mail/cltbld', 05:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:04 INFO - 'MOZ_NO_REMOTE': '1', 05:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:04 INFO - 'NO_EM_RESTART': '1', 05:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:04 INFO - 'PWD': '/builds/slave/test', 05:20:04 INFO - 'SHELL': '/bin/bash', 05:20:04 INFO - 'SHLVL': '1', 05:20:04 INFO - 'TERM': 'linux', 05:20:04 INFO - 'TMOUT': '86400', 05:20:04 INFO - 'USER': 'cltbld', 05:20:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:04 INFO - '_': '/tools/buildbot/bin/python'} 05:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:04 INFO - Downloading/unpacking psutil>=3.1.1 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:06 INFO - Installing collected packages: psutil 05:20:06 INFO - Running setup.py install for psutil 05:20:06 INFO - building 'psutil._psutil_linux' extension 05:20:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:20:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:20:06 INFO - building 'psutil._psutil_posix' extension 05:20:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:20:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:06 INFO - Successfully installed psutil 05:20:06 INFO - Cleaning up... 05:20:07 INFO - Return code: 0 05:20:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:07 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:20:07 INFO - Using env: {'DISPLAY': ':0', 05:20:07 INFO - 'HOME': '/home/cltbld', 05:20:07 INFO - 'LANG': 'en_US.UTF-8', 05:20:07 INFO - 'LANGUAGE': 'en_US:en', 05:20:07 INFO - 'LOGNAME': 'cltbld', 05:20:07 INFO - 'MAIL': '/var/mail/cltbld', 05:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:07 INFO - 'MOZ_NO_REMOTE': '1', 05:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:07 INFO - 'NO_EM_RESTART': '1', 05:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:07 INFO - 'PWD': '/builds/slave/test', 05:20:07 INFO - 'SHELL': '/bin/bash', 05:20:07 INFO - 'SHLVL': '1', 05:20:07 INFO - 'TERM': 'linux', 05:20:07 INFO - 'TMOUT': '86400', 05:20:07 INFO - 'USER': 'cltbld', 05:20:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:07 INFO - '_': '/tools/buildbot/bin/python'} 05:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:09 INFO - Installing collected packages: mozsystemmonitor 05:20:09 INFO - Running setup.py install for mozsystemmonitor 05:20:09 INFO - Successfully installed mozsystemmonitor 05:20:09 INFO - Cleaning up... 05:20:09 INFO - Return code: 0 05:20:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:20:09 INFO - Using env: {'DISPLAY': ':0', 05:20:09 INFO - 'HOME': '/home/cltbld', 05:20:09 INFO - 'LANG': 'en_US.UTF-8', 05:20:09 INFO - 'LANGUAGE': 'en_US:en', 05:20:09 INFO - 'LOGNAME': 'cltbld', 05:20:09 INFO - 'MAIL': '/var/mail/cltbld', 05:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:09 INFO - 'MOZ_NO_REMOTE': '1', 05:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:09 INFO - 'NO_EM_RESTART': '1', 05:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:09 INFO - 'PWD': '/builds/slave/test', 05:20:09 INFO - 'SHELL': '/bin/bash', 05:20:09 INFO - 'SHLVL': '1', 05:20:09 INFO - 'TERM': 'linux', 05:20:09 INFO - 'TMOUT': '86400', 05:20:09 INFO - 'USER': 'cltbld', 05:20:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:09 INFO - '_': '/tools/buildbot/bin/python'} 05:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:11 INFO - warning: no files found matching '*.txt' 05:20:11 INFO - no previously-included directories found matching 'build' 05:20:11 INFO - no previously-included directories found matching 'dist' 05:20:11 INFO - no previously-included directories found matching '.git*' 05:20:11 INFO - Installing collected packages: jsonschema, functools32 05:20:11 INFO - Running setup.py install for functools32 05:20:11 INFO - warning: no files found matching '*.txt' 05:20:11 INFO - no previously-included directories found matching 'build' 05:20:11 INFO - no previously-included directories found matching 'dist' 05:20:11 INFO - no previously-included directories found matching '.git*' 05:20:11 INFO - Successfully installed jsonschema functools32 05:20:11 INFO - Cleaning up... 05:20:11 INFO - Return code: 0 05:20:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', '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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:20: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 blobuploader==1.2.4 05:20:11 INFO - Using env: {'DISPLAY': ':0', 05:20:11 INFO - 'HOME': '/home/cltbld', 05:20:11 INFO - 'LANG': 'en_US.UTF-8', 05:20:11 INFO - 'LANGUAGE': 'en_US:en', 05:20:11 INFO - 'LOGNAME': 'cltbld', 05:20:11 INFO - 'MAIL': '/var/mail/cltbld', 05:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:11 INFO - 'MOZ_NO_REMOTE': '1', 05:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:11 INFO - 'NO_EM_RESTART': '1', 05:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:11 INFO - 'PWD': '/builds/slave/test', 05:20:11 INFO - 'SHELL': '/bin/bash', 05:20:11 INFO - 'SHLVL': '1', 05:20:11 INFO - 'TERM': 'linux', 05:20:11 INFO - 'TMOUT': '86400', 05:20:11 INFO - 'USER': 'cltbld', 05:20:11 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:11 INFO - '_': '/tools/buildbot/bin/python'} 05:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:14 INFO - Downloading docopt-0.6.1.tar.gz 05:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:14 INFO - Running setup.py install for blobuploader 05:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:14 INFO - Running setup.py install for requests 05:20:15 INFO - Running setup.py install for docopt 05:20:15 INFO - Successfully installed blobuploader requests docopt 05:20:15 INFO - Cleaning up... 05:20:15 INFO - Return code: 0 05:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:15 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:15 INFO - Using env: {'DISPLAY': ':0', 05:20:15 INFO - 'HOME': '/home/cltbld', 05:20:15 INFO - 'LANG': 'en_US.UTF-8', 05:20:15 INFO - 'LANGUAGE': 'en_US:en', 05:20:15 INFO - 'LOGNAME': 'cltbld', 05:20:15 INFO - 'MAIL': '/var/mail/cltbld', 05:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:15 INFO - 'MOZ_NO_REMOTE': '1', 05:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:15 INFO - 'NO_EM_RESTART': '1', 05:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:15 INFO - 'PWD': '/builds/slave/test', 05:20:15 INFO - 'SHELL': '/bin/bash', 05:20:15 INFO - 'SHLVL': '1', 05:20:15 INFO - 'TERM': 'linux', 05:20:15 INFO - 'TMOUT': '86400', 05:20:15 INFO - 'USER': 'cltbld', 05:20:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:15 INFO - '_': '/tools/buildbot/bin/python'} 05:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:15 INFO - Running setup.py (path:/tmp/pip-BrmHQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:15 INFO - Running setup.py (path:/tmp/pip-NHQYr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:15 INFO - Running setup.py (path:/tmp/pip-EoPpHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:15 INFO - Running setup.py (path:/tmp/pip-UFj7Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:15 INFO - Running setup.py (path:/tmp/pip-5MZpbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:16 INFO - Running setup.py (path:/tmp/pip-Kzl7wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:16 INFO - Running setup.py (path:/tmp/pip-ovjFmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:16 INFO - Running setup.py (path:/tmp/pip-xHw3VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:16 INFO - Running setup.py (path:/tmp/pip-zYJtsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:16 INFO - Running setup.py (path:/tmp/pip-1s0wug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:16 INFO - Running setup.py (path:/tmp/pip-HQ0IfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:16 INFO - Running setup.py (path:/tmp/pip-IoriY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:16 INFO - Running setup.py (path:/tmp/pip-sTslSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:16 INFO - Running setup.py (path:/tmp/pip-nL8xI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:16 INFO - Running setup.py (path:/tmp/pip-GAJDJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:16 INFO - Running setup.py (path:/tmp/pip-tOV7Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:16 INFO - Running setup.py (path:/tmp/pip-uMWRZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:16 INFO - Running setup.py install for manifestparser 05:20:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:16 INFO - Running setup.py install for mozcrash 05:20:17 INFO - Running setup.py install for mozdebug 05:20:17 INFO - Running setup.py install for mozdevice 05:20:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Running setup.py install for mozfile 05:20:17 INFO - Running setup.py install for mozhttpd 05:20:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Running setup.py install for mozinfo 05:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Running setup.py install for mozInstall 05:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Running setup.py install for mozleak 05:20:17 INFO - Running setup.py install for mozlog 05:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:17 INFO - Running setup.py install for moznetwork 05:20:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Running setup.py install for mozprocess 05:20:18 INFO - Running setup.py install for mozprofile 05:20:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Running setup.py install for mozrunner 05:20:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Running setup.py install for mozscreenshot 05:20:18 INFO - Running setup.py install for moztest 05:20:18 INFO - Running setup.py install for mozversion 05:20:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:18 INFO - Cleaning up... 05:20:18 INFO - Return code: 0 05:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:18 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:18 INFO - Using env: {'DISPLAY': ':0', 05:20:18 INFO - 'HOME': '/home/cltbld', 05:20:18 INFO - 'LANG': 'en_US.UTF-8', 05:20:18 INFO - 'LANGUAGE': 'en_US:en', 05:20:18 INFO - 'LOGNAME': 'cltbld', 05:20:18 INFO - 'MAIL': '/var/mail/cltbld', 05:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:18 INFO - 'MOZ_NO_REMOTE': '1', 05:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:18 INFO - 'NO_EM_RESTART': '1', 05:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:18 INFO - 'PWD': '/builds/slave/test', 05:20:18 INFO - 'SHELL': '/bin/bash', 05:20:18 INFO - 'SHLVL': '1', 05:20:18 INFO - 'TERM': 'linux', 05:20:18 INFO - 'TMOUT': '86400', 05:20:18 INFO - 'USER': 'cltbld', 05:20:18 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:18 INFO - '_': '/tools/buildbot/bin/python'} 05:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:18 INFO - Running setup.py (path:/tmp/pip-xGDLiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:18 INFO - Running setup.py (path:/tmp/pip-NpamdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:19 INFO - Running setup.py (path:/tmp/pip-4wmoX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:19 INFO - Running setup.py (path:/tmp/pip-lxgpf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:19 INFO - Running setup.py (path:/tmp/pip-gJB5QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:19 INFO - Running setup.py (path:/tmp/pip-vllBsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:19 INFO - Running setup.py (path:/tmp/pip-__sJp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:19 INFO - Running setup.py (path:/tmp/pip-rFs8BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:19 INFO - Running setup.py (path:/tmp/pip-DMLxab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:19 INFO - Running setup.py (path:/tmp/pip-nfXbFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:19 INFO - Running setup.py (path:/tmp/pip-l8S79q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:19 INFO - Running setup.py (path:/tmp/pip-qMtwaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:19 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)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:19 INFO - Running setup.py (path:/tmp/pip-8MaHsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:19 INFO - Running setup.py (path:/tmp/pip-KDks3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:19 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)) 05:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:19 INFO - Running setup.py (path:/tmp/pip-j6Cw0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:20 INFO - Running setup.py (path:/tmp/pip-hYuLzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:20 INFO - Running setup.py (path:/tmp/pip-KvqtdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:22 INFO - Downloading blessings-1.6.tar.gz 05:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:22 INFO - Installing collected packages: blessings 05:20:22 INFO - Running setup.py install for blessings 05:20:22 INFO - Successfully installed blessings 05:20:22 INFO - Cleaning up... 05:20:22 INFO - Return code: 0 05:20:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:22 INFO - Reading from file tmpfile_stdout 05:20:22 INFO - Current package versions: 05:20:22 INFO - argparse == 1.2.1 05:20:22 INFO - blessings == 1.6 05:20:22 INFO - blobuploader == 1.2.4 05:20:22 INFO - docopt == 0.6.1 05:20:22 INFO - functools32 == 3.2.3-2 05:20:22 INFO - jsonschema == 2.5.1 05:20:22 INFO - manifestparser == 1.1 05:20:22 INFO - mozInstall == 1.12 05:20:22 INFO - mozcrash == 0.17 05:20:22 INFO - mozdebug == 0.1 05:20:22 INFO - mozdevice == 0.48 05:20:22 INFO - mozfile == 1.2 05:20:22 INFO - mozhttpd == 0.7 05:20:22 INFO - mozinfo == 0.9 05:20:22 INFO - mozleak == 0.1 05:20:22 INFO - mozlog == 3.2 05:20:22 INFO - moznetwork == 0.27 05:20:22 INFO - mozprocess == 0.23 05:20:22 INFO - mozprofile == 0.28 05:20:22 INFO - mozrunner == 6.12 05:20:22 INFO - mozscreenshot == 0.1 05:20:22 INFO - mozsystemmonitor == 0.3 05:20:22 INFO - moztest == 0.7 05:20:22 INFO - mozversion == 1.4 05:20:22 INFO - psutil == 3.1.1 05:20:22 INFO - requests == 1.2.3 05:20:22 INFO - wsgiref == 0.1.2 05:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:22 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:22 INFO - Using env: {'DISPLAY': ':0', 05:20:22 INFO - 'HOME': '/home/cltbld', 05:20:22 INFO - 'LANG': 'en_US.UTF-8', 05:20:22 INFO - 'LANGUAGE': 'en_US:en', 05:20:22 INFO - 'LOGNAME': 'cltbld', 05:20:22 INFO - 'MAIL': '/var/mail/cltbld', 05:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:22 INFO - 'MOZ_NO_REMOTE': '1', 05:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:22 INFO - 'NO_EM_RESTART': '1', 05:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:22 INFO - 'PWD': '/builds/slave/test', 05:20:22 INFO - 'SHELL': '/bin/bash', 05:20:22 INFO - 'SHLVL': '1', 05:20:22 INFO - 'TERM': 'linux', 05:20:22 INFO - 'TMOUT': '86400', 05:20:22 INFO - 'USER': 'cltbld', 05:20:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:22 INFO - '_': '/tools/buildbot/bin/python'} 05:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:22 INFO - Cleaning up... 05:20:22 INFO - Return code: 0 05:20:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:22 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 0x2544030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2805180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:20:22 INFO - Using env: {'DISPLAY': ':0', 05:20:22 INFO - 'HOME': '/home/cltbld', 05:20:22 INFO - 'LANG': 'en_US.UTF-8', 05:20:22 INFO - 'LANGUAGE': 'en_US:en', 05:20:22 INFO - 'LOGNAME': 'cltbld', 05:20:22 INFO - 'MAIL': '/var/mail/cltbld', 05:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:22 INFO - 'MOZ_NO_REMOTE': '1', 05:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:22 INFO - 'NO_EM_RESTART': '1', 05:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:22 INFO - 'PWD': '/builds/slave/test', 05:20:22 INFO - 'SHELL': '/bin/bash', 05:20:22 INFO - 'SHLVL': '1', 05:20:22 INFO - 'TERM': 'linux', 05:20:22 INFO - 'TMOUT': '86400', 05:20:22 INFO - 'USER': 'cltbld', 05:20:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:22 INFO - '_': '/tools/buildbot/bin/python'} 05:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:22 INFO - Cleaning up... 05:20:22 INFO - Return code: 0 05:20:22 INFO - Running post-action listener: _resource_record_post_action 05:20:22 INFO - Running post-action listener: _start_resource_monitoring 05:20:23 INFO - Starting resource monitoring. 05:20:23 INFO - ##### 05:20:23 INFO - ##### Finished create-virtualenv step (success) 05:20:23 INFO - ##### 05:20:23 INFO - ##### 05:20:23 INFO - ##### Running install step. 05:20:23 INFO - ##### 05:20:23 INFO - Running pre-action listener: _resource_record_pre_action 05:20:23 INFO - Running main action method: install 05:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:23 INFO - Reading from file tmpfile_stdout 05:20:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:23 INFO - Reading from file tmpfile_stdout 05:20:23 INFO - Output received: 05:20:23 INFO - Usage: mozinstall [options] installer 05:20:23 INFO - Options: 05:20:23 INFO - -h, --help show this help message and exit 05:20:23 INFO - -d DEST, --destination=DEST 05:20:23 INFO - Directory to install application into. [default: 05:20:23 INFO - "/builds/slave/test"] 05:20:23 INFO - --app=APP Application being installed. [default: firefox] 05:20:23 INFO - mkdir: /builds/slave/test/build/application 05:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:20:40 INFO - Reading from file tmpfile_stdout 05:20:40 INFO - Output received: 05:20:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:40 INFO - Running post-action listener: _resource_record_post_action 05:20:40 INFO - ##### 05:20:40 INFO - ##### Finished install step (success) 05:20:40 INFO - ##### 05:20:40 INFO - ##### 05:20:40 INFO - ##### Running run-tests step. 05:20:40 INFO - ##### 05:20:40 INFO - Running pre-action listener: _resource_record_pre_action 05:20:40 INFO - Running main action method: run_tests 05:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:40 INFO - Python 2.7.3 05:20:40 INFO - Return code: 0 05:20:40 INFO - grabbing minidump binary from tooltool 05:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:40 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 0x28033b0>, '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 0x28042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2804740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:20:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:20:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:20:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:40 INFO - Return code: 0 05:20:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:40 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/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:20:40 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/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:20:40 INFO - Using env: {'DISPLAY': ':0', 05:20:40 INFO - 'HOME': '/home/cltbld', 05:20:40 INFO - 'LANG': 'en_US.UTF-8', 05:20:40 INFO - 'LANGUAGE': 'en_US:en', 05:20:40 INFO - 'LOGNAME': 'cltbld', 05:20:40 INFO - 'MAIL': '/var/mail/cltbld', 05:20:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:40 INFO - 'MOZ_NO_REMOTE': '1', 05:20:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:40 INFO - 'NO_EM_RESTART': '1', 05:20:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:40 INFO - 'PWD': '/builds/slave/test', 05:20:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:40 INFO - 'SHELL': '/bin/bash', 05:20:40 INFO - 'SHLVL': '1', 05:20:40 INFO - 'TERM': 'linux', 05:20:40 INFO - 'TMOUT': '86400', 05:20:40 INFO - 'USER': 'cltbld', 05:20:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725', 05:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:40 INFO - '_': '/tools/buildbot/bin/python'} 05:20:40 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/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:20:40 INFO - mozversion application_buildid: 20160718023044 05:20:40 INFO - mozversion application_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:20:40 INFO - mozversion application_display_name: Nightly 05:20:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:40 INFO - mozversion application_name: Firefox 05:20:40 INFO - mozversion application_remotingname: firefox 05:20:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:20:40 INFO - mozversion application_vendor: Mozilla 05:20:40 INFO - mozversion application_version: 50.0a1 05:20:40 INFO - mozversion platform_buildid: 20160718023044 05:20:40 INFO - mozversion platform_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:20:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:20:40 INFO - mozversion platform_version: 50.0a1 05:20:40 INFO - using testdate: 1468844440 05:20:40 INFO - actual date: 1468844440 05:20:40 INFO - starting webserver on 'localhost:60508' 05:20:40 INFO - SUITE-START | Running 2 tests 05:20:40 INFO - TEST-START | dromaeo_css 05:20:40 INFO - operating with platform_type : linux_ 05:20:40 INFO - Initialising browser for dromaeo_css test... 05:20:40 INFO - TEST-INFO | started process 26534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaB2PuV/profile http://localhost:60508/getInfo.html) 05:20:43 INFO - PROCESS | 26534 | JavaScript error: , line 0: uncaught exception: undefined 05:20:44 INFO - PROCESS | 26534 | __metrics Screen width/height:1600/1200 05:20:44 INFO - PROCESS | 26534 | colorDepth:24 05:20:44 INFO - PROCESS | 26534 | Browser inner width/height: 1024/697 05:20:44 INFO - PROCESS | 26534 | __metrics 05:20:45 INFO - PROCESS | 26534 | 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" 05:20:45 INFO - PROCESS | 26534 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:46 INFO - TEST-INFO | 26534: exit 0 05:20:46 INFO - Browser initialized. 05:20:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:46 INFO - TEST-INFO | started process 26618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaB2PuV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:58 INFO - PROCESS | 26618 | RSS: Main: 157728768 05:20:58 INFO - PROCESS | 26618 | 05:21:49 INFO - PROCESS | 26618 | 1468844509577 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:23:57 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60508/tests/dromaeo/cssquery-ext.html) 05:23:58 INFO - PROCESS | 26618 | RSS: Main: 248008704 05:23:58 INFO - PROCESS | 26618 | 05:27:00 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-ext.html (next: http://localhost:60508/tests/dromaeo/cssquery-jquery.html) 05:27:01 INFO - PROCESS | 26618 | RSS: Main: 247054336 05:27:01 INFO - PROCESS | 26618 | 05:30:03 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60508/tests/dromaeo/cssquery-mootools.html) 05:30:03 INFO - PROCESS | 26618 | RSS: Main: 248074240 05:30:03 INFO - PROCESS | 26618 | 05:33:05 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60508/tests/dromaeo/cssquery-prototype.html) 05:33:06 INFO - PROCESS | 26618 | RSS: Main: 243789824 05:33:06 INFO - PROCESS | 26618 | 05:36:09 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60508/tests/dromaeo/cssquery-yui.html) 05:36:09 INFO - PROCESS | 26618 | RSS: Main: 226451456 05:36:09 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-yui.html (next: http://localhost:60508/tests/dromaeo/cssquery-dojo.html) 05:39:12 INFO - PROCESS | 26618 | RSS: Main: 301481984 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | __start_tp_report 05:39:12 INFO - PROCESS | 26618 | _x_x_mozilla_page_load 05:39:12 INFO - PROCESS | 26618 | _x_x_mozilla_page_load_details 05:39:12 INFO - PROCESS | 26618 | |i|pagename|runs| 05:39:12 INFO - PROCESS | 26618 | |0;dojo.html;3049.6950304969505;3068.907932762017;3082.599262095926;3111.891083812067;3147.055883235029;5257.080010998079;5327.36071671399;5345.973270133649;5424.457554244578;5426.21319908613;5327.200919862023;5356.625036247464;5379.569634429236;5398.13629819229;5447.291852059237;4840.782164802575;4868.805247790084;4918.139325618003;4926.137925862978;5043.899122017558;4949.356583644121;4951.0592987332475;4986.5013498650205;4996.875078123039;5013.623978201631;4763.2378819388905;4806.639502037361;4867.683600565952;4910.165271903749;4956.430010548797;4878.073166098466;4881.707097574157;4888.046830867982;4946.35697359341;4975.203967365241;4889.584385327252;4914.04176185644;4918.704877707349;4918.7786549605;4941.474658976394;5168.819091331823;5221.034108689904;5295.814646487393;5297.841064768025;5450.345958484968;5666.291713535808;5706.28671416073;5718.056520674084;5719.370869204384;5721.399253078408;5688.089905615082;5704.714764261812;5732.942670573324;5756.338021127582;5757.395473475267;5247.895042099175;5324.627276090675;5356.678599284055;5374.865628359323;5430.5927055471;5952.76188952437;5957.910631340534;5962.910556341659;5965.79119730816;5969.641821490724;5462.0441422751655;5679.375268720438;5706.4864162225595;5710.2576665033275;5710.486056254957;5686.800961966312;5740.971295143581;5774.797882074107;5833.270841144857;5835.416458354131;5752.654840709571;5755.165501002331;5762.394948530344;5762.88474230513;5803.129530570363;5576.860578485489;5669.348024977098;5802.738876750556;5808.041673123887;5812.709364531841;4361.411209486679;4385.3641222022625;4390.582894625006;4423.668224883147;4431.933520997188;3900.551436584772;3903.941440878389;3922.9803850981134;3926.3521518949624;3953.189596132786;5256.684598924076;5372.113601255749;5380.704061276668;5486.725663716878;5528.06022976095;5726.541876649858;5728;5745.023346031185;5756.510696590837;5804.361520232771;5437.401885792559;5448.128299472065;5449.455054494598;5454.209139674805;5455.563554915597;4885.316055752198;4887.266909963534;4932.654714170046;4969.801207951714;5011.1481048221885;5912.113183022581;5917.852053698692;5918.970405147947;5930.970345148246;5968.492678122321;5717.22817419643;5722.341930678025;5729.3984131665575;5730.054541000688;5731.656100633975;5777.537796976148;5894.528437724886;5922.822315330547;5964.880702385841;5982.4316689914385;5686.516646085129;5689.459501347365;5692.829215123553;5693.715314234189;5699.230603868425;5738.655680659173;5801.332846722681;5806.854828629318;5811.883762324815;5812.331581868139;5481.671099734029;5585.106382978866;5638.069718496567;5652.7173641318595;5654.886902262014;5634.464725851038;5643.294588176478;5644.88710225785;5646;5652.0674088774895;5398.13629819227;5518.310211223597;5583.218349431002;5586.692731899784;5587.608867379245;5590.413006634245;5613.494785469327;5616.831495055155;5628.1557766333735;5668.858278542904;5485.067538518541;5491.945080549143;5496.917546236889;5497.312835895513;5499.890002200013 05:39:12 INFO - PROCESS | 26618 | |1;ext.html;629.288903539001;652.7225928980182;661.4741280681858;673.2762280548411;686.9416099631532;43062.56937430629;44746.32880506791;45065.549344506544;48505.51494485054;48554.51445485544;46023.769881150634;46599.30101048487;46608;46631.300530492066;46693.53306466934;9029.413088149266;9141.085891410872;9156.816863662723;9174.495402752846;9176.449413035205;8949.910500895005;9041.547922603877;9043.819123617524;9044.3668943174;9045.276377889753;9144.08559144087;9195.586198621078;9197.954010229972;9198.678046268382;9205.907940920606;9016.729498115066;9114.908850911472;9153.908460915438;9160.679376221868;9161.450312981242;8983.82032359349;9061;9066.410683305565;9067;9095.772605684844;43602.78198608987;43886;43962.78018609918;44115.55884441147;44205.336919946225;3561.786292822439;3628.6601641182187;3651.8174091295327;3726.366517691999;3763.5295588051495;31872;31942.520862187084;32449.351012979845;32679.346413071606;33308.167295817795;4530.93203601943;4594.558182934069;4627.583517483409;4630.073985202973;4738.739369334685;347394;348634;349158;349682;351090;61230;61442.38557614456;61476.38523614706;61731.691341543;61817.38182618206;57595.42404575984;64119.358806411336;65535.67232163904;65619;72618;17480.388186413413;17624.823751762317;17636.118194090242;17640.647187056442;17652.735208971877;12296.262224266573;13374.799378009338;13472.663183420493;13477.595672129852;13483.595492135251;19439.611207775764;19622.5471816023;19927.202911883363;20631.17475301001;20652.48368790762;7078.1506219254015;7290.744823931243;7293.635318234067;7309.342159205697;7474.439417043744;1000.7197984564334;1053.510117795229;1078.6925726168004;1102.3000394749392;1127.6504283672089;33090.338193236;33574.328513429595;33710;33728.49407258893;34071.488927666105;1139.9316041037564;1142.1662186603826;1201.7656556971306;1226.834377359063;1235.1909499277988;17340.132993350282;17916.10419479021;17935.282588696566;17943.39068003929;18023.18895649699;542817;544825;549487;551507;552209;60194;60433.69783151056;60984.39015609787;60988.39011609916;61043.69478152581;1264.7470505898673;1345.9932700336435;1380.9240491773048;1404.676924307415;1426.8073810035512;31159.376812464077;34522;34728;34833.47749783806;34940.47589286112;51463.48536514737;51566.22650660168;52129;52166.47833521616;52181.7390913043;322578;322986;323690;323891;324557;28453.288667783472;28719.42561148807;29002.41995160127;29083.41833163367;30517.694823052374;49759.751201243766;49956.250656239456;50708.74645626748;51500.22749658833;51579;41897;42066.57933420627;42751.78624106859;43059.354109689004;43152.35271470868;42334.57665423306;42617;42744;42862.14275714531;43798.34302485402;42855.785721071195;43760.562394376924;43963.56036439595;44070;44130.338044929995;35818.82090589531;36729.44905826361;36893;37884.62115378921;38029.809850950565;28892.133236002952;29013.709862901946;29022.12933611995;29182.27044323909;29260.853695731385 05:39:12 INFO - PROCESS | 26618 | |2;jquery.html;365.581409286367;394.8775879477361;399.8480577380593;400.8276441130314;418.474814108294;14456.957851666468;17862.553436164104;19280.614387712274;19861.20555177793;19863.10616022279;18665.160067796947;18704.532386690338;18876.622467550642;18897.055147242616;18901.43295701128;4114.876553703379;5592.99999999999;5791.218185544961;5791.681457519835;5792.420757924216;6467.256265529477;6611.669416529155;6616.867662646744;6619.536632435731;6619.669016549154;6331.2085989251345;6509.4466970307585;6546.9017964730565;6576.375244351779;6579.60522368657;6306.274778400497;6527.640979746136;6535.54251202416;6543.672816359187;6574.835629109287;5675.914861277084;5692.9146062809095;5703.77184912603;5705.6006079574445;5706.029974904276;23739.05043798246;23760.76239237603;23937.162199322942;24625.261242162764;24672.13647522328;2526.2295000024983;2611.6082587611822;2992.2968102495897;3111.579936708538;3145.874165033396;14675.266236688123;14883.553493395108;15015.774763378558;15093;15177.544673659808;1713.7943446786342;1788.5260405992422;1790.7672002639574;1794.3223086414243;1881.9623607527774;82170.17829821745;82181;84114.57942710309;84890.57554712248;85549;10001.399916005063;10100.191984641211;10308.896911030793;10664.253502254924;10691.251612387214;13827.930860345836;13845.930770346084;13912.652183695287;13943.721125577635;13944.442222311196;7973.481723687942;8200.712975045844;8234;8271.875921861178;8316.625751841182;8195.262426381654;8202.835943281101;8227.053888802864;8413.15868413166;8425.157484251526;6519.4132528072705;6538.803835884836;6656.167979002625;6681.365270299314;6758.357955994173;1763.1713094845402;1774.378967361439;1818.8908665479848;1838.3841413126752;1868.831805137544;1023.6161439460202;1045.9633912813015;1058.640062378795;1085.1698450685233;1091.410638255349;19986.90006549958;20204.494887627632;20292.391228263175;20377.694334584994;20398.388048358574;1015.1574193419444;1033.7260625934134;1043.3062013760764;1045.5869931377215;1051.1433181956681;10872;11596.246243994114;11655.41722913851;11748.88251117495;11760.88239117598;488916;498673;501819;504343;504913;82525;85025;86285.56857215674;88025;88233;1031.1493018259816;1053.1259054984343;1066.3122286125406;1079.4764539198482;1080.5407701726735;17835.197416116047;18042.2783088675;18368.173432195315;18489.53776155607;18621.162047707614;40907.59092409038;41328.58671413368;41350.37974430446;42145.36781948212;42734.786326069414;54086.45913540814;55772.44227557672;56594;56737.71631141983;56804.43195567992;5648.4633959773755;6454.903176452451;8032.919670803217;8826.735197944072;8958.462492250486;12574.30841303737;13536.932315338361;13741.312934353442;13936.961834273627;13952.930235348758;12067;12236.449359778653;12249.08131890094;12332.81500777507;12688.429020693906;12077.214981026205;12157.756844862877;12190.817137742764;12238.816417753918;12509.437075331814;12255.32595707209;12385.566505172275;12468.127231093737;12480.188787728768;12626.747465050832;7699.6535155917;8068.636911338886;8070.959645201971;8089;9094.136057074567;11323.716907077389;11662.650120496399;11682.4742886572;12131.454084566392;12420.875791241971 05:39:12 INFO - PROCESS | 26618 | |3;mootools.html;1365.6790654196268;1445.7903603977427;1514.8788096952244;1632.2165360626898;1803.4138904855918;8289.66841326347;8554;8585.441946273495;8870;8879.067697891725;8624.784380390493;8805.64777408903;8807.603657835396;8812.38313318068;8827.161419665137;2249.6175650139476;2256.4810093678466;2257.9661305080435;2274.442761523429;2275.1923067311113;2286.222684287342;2352.070931981866;2361.0791791201445;2370.6444033394955;2372.7389987101405;2274.5109801392696;2282.6233671444193;2298.069281940817;2305.2853615379204;2313.155698170164;2221.6556433752794;2226.376614547929;2235.251190851067;2239.4625289930464;2240.63029600115;2266.3994041578994;2266.9886650566805;2274.8748818814956;2277.5331057133412;2277.920272790461;8724.956375218084;8773.736787896374;8829.337799664987;8836.513991730451;9041.593128309176;5136.203888397305;5235.214717792323;5242.1088414969545;5244.8688782780355;5246.737663116867;3248.2691394436297;3306.9007929762147;3311.3708395404797;3334.61651910031;3365.4951757236367;1041.8020576090519;1061.7239517725448;1062.4422178356347;1074.1460538871615;1076.3272954403499;12242.81635775464;12311.19977201479;12341.07441941849;12387.504499820086;12388.876111238953;4261.616454519108;4407.713498622579;4463.531329210451;4536.206163921301;4539.273716205391;9858.802823943624;9881.654142105135;9884.703458896101;9888.604455821687;9896.307258491837;5179.352580927384;5180.974095129575;5182.481751824863;5184.248283998874;5185.144451165591;4244.957550424456;4683.882902927386;4835.1296766581645;4840.83057093;4853.320535125085;3786.6024067473068;3805.0867791729784;3886.514185726784;3899.200663863901;3917.941230881539;1101.553870682375;1110.3781882146025;1116.5031560955297;1117.2458590451413;1118.1837258800958;1007.2395341517108;1012.8632634594383;1013.9239557033252;1030.4126647810676;1035.2028937718067;5959.5828292020005;6112.144299798032;6206.162168107338;6244.75020999164;6309.2428908530355;428.9742615443083;429.76363000350307;430.07104653947323;433.741923555484;442.7498463368187;4163.666906647461;4390.319500477431;4391.736495810262;4401.911961760811;4425.070735145591;10759.731006724738;11027.724306892393;11056.557737690402;11076.446177691083;11089.500972456259;10426.218033647507;10800.567977280822;10996.450177491093;11007.834882476769;11008.39453830031;8203.466774659628;8247.752567422987;8341.04078031022;8377.49735015901;8402.495850248883;6164.753409863555;6346.492280617447;6367.140436041075;6371.617702937839;6518.771842985473;10188.592456301962;10204.846927295948;10253.538590763284;10312.896871031493;10322.48387580633;9812.803743924938;10076.042775936274;10086.344387614781;10398.480075996322;10480;6895.827604309932;7087.539309944837;7098.787036388917;7938.722144724907;8082.515049097073;7698.2686644768655;8367.623456944573;8616.48301101936;8623.913760862311;8837.91162088371;7786.4938778979185;7794.844103118019;7884.960575197088;7922.247386498273;8019.238172373615;7568.886466703114;7794.688212471665;7900.222449948716;8024.277814996678;8058.355331573577;7229.710811567478;7341.853162936604;7479.326860582573;7488.326050655467;7503.5497870127965;4999.10016197088;5118.74406279692;5119.846404607868;5133.153029750049;5216.243644671577;5018.799248030038;5148.459411761711;5182.922256166085;5185.974070129625;5284.154535274338 05:39:12 INFO - PROCESS | 26618 | |4;prototype.html;320.9985738917848;325.56862157641126;333.8664534186325;335.7247057412919;337.8142021887961;5318.095923692972;5385.165299378593;5394.1908713692965;5405.972970135149;5407.972960135204;5317.46825317468;5345.812896548621;5347.946520534793;5348.5453736432355;5371.818199996004;4087.4686290782306;4238.936415953764;4243.427137336451;4245.893852653693;4247.638950689196;4186.853460128896;4246.299360605496;4247.193033323674;4267.935980960288;4272.978635106821;4155.005597313277;4173.749575025508;4197.313719219686;4202.348635961431;4216.325387937931;3943.2310699413624;4014.498187726534;4055.695822813271;4073.5111786585503;4182.707210495267;3579.1231148368556;3643.1802844360072;3643.653852883972;3650.945235821465;3653.7077033837495;5156.9742151289;5164.6384753067305;5189.481051894818;5196.584273258168;5203.895922081537;4750;4778.880527986794;4802.567768900815;4808.01435705683;4808.61531077513;5589.888202235973;5609.1305847593685;5615.522680572156;5629.887402251973;5630.690312032836;4050.2709512287774;4053.61490658387;4057.310257256244;4057.5942405759483;4058.7271128168322;5687.544996400278;5754.280714910637;5770.596058275923;5824.825255242349;5858.297004359504;4095.119549296856;4104.850641820295;4106.7535947842625;4108.014076621649;4114.897127571775;4145.17096580685;4151.73013754105;4152.771597562163;4152.958470415258;4165.146145040259;4499.212637788374;4780;4780.490242622651;4783.4499032611;4786.7845946932475;5613.905288468791;5638.718064096779;5652.660840349592;5654.264945557051;5655.886882262332;1413.7949997250341;1435.992820035914;1441.80535627691;1446.4720377062297;1446.5443385333585;873.9082396348292;927.8051609162152;928.2759447630858;936.9531523423801;940.47333493244;4889;4921.581665558396;4928.605711543068;4937.308776771255;4976.62675299354;5085.211792172219;5137.460566640524;5141.794328226903;5145.434002259748;5163.586913047023;4878.121938051114;4917.065757506062;4943.132982869927;5001.824936127218;5153.6907785532985;2983.686712895158;3032.605761251067;3043.239190202449;3062.4487592233168;3062.785605007628;5919.4968427684125;5949.732262048218;5975.52195824333;6032.728527216198;6050;5659.518940889988;5852.473277405054;5867.295924489089;5872.471477567039;5957.851053723605;5857.648541087548;5863.970680146572;5887.087501437284;5902.2327097477055;5947.464728174485;5607;5689;5703.116017017369;5729.656220626775;5748.798792042258;5701.771929122789;5736.282964629421;5747.620571062998;5757.481826635623;5763.242211125647;5895.380984996686;5950.761969521171;5954.225950626565;6031.366706495754;6032.939670603413;3987.892470755127;4010.438538604539;4059.6752259818554;4062.431259623596;4076.2255171517318;5728.770849165987;5737.74180161902;5738.364566098642;5764.481196692318;5773.162891380643;5621.7189140542;5636.323641162922;5657.264555607745;5657.717114144359;5660.490555849993;5420.674759514442;5535.916961245504;5563.388027316911;5612.382637909745;5636.689982051026;5377.758000889891;5502.422245664307;5512.503874651301;5529.917051244154;5575.104464482096;5297.337832770903;5585.989043944258;5594.41258667834;5597.80407685729;5598.440155984369;5481.410390986569;5484.424135465878;5487.64330318528;5495.670259784426;5523.6685798852195 05:39:12 INFO - PROCESS | 26618 | |5;yui.html;769.1385648074158;781.2888283649593;839.7019058234325;845;850.591715976331;14124.505642302509;14174.291285435713;14484.637884052903;14504.854951450483;14509.49216777413;14348;14475.855241447582;14485.348159332829;14514;14521.927390363033;686.6566716641679;791.9762407127795;805.4402190477621;828.3456069704926;830.016430529821;837.2673910328463;837.3552364679193;839.7144970709958;839.7354833227545;839.7942504086508;877.9561021948876;878.8110556230409;879.5953861223845;879.8020445399798;879.8768172455862;703.9190493093308;839.215333663027;859.3726579596866;862.4738909265343;874.6632546469623;626.0515319291277;626.9498440124825;627.0531497438855;627.0594108836744;627.4447114303829;14226.430942762277;14275.928620356935;14280;14288.142711437347;14301.284935753274;13815.585532434043;13941.790873136912;14027.929860350734;14082.225477598728;14376.784348234785;12581.433835477334;12668.95579858281;12691.492340306377;12819.871801282054;12958.676033099153;4200.306949353353;4252.596003379674;4317.775571002979;4324.416203812508;4372.256716358227;71044.28955710429;74061;74154.25845741581;76245.61877190579;83900.99999999939;11328.150388720878;11457.59898403552;11496.137789665809;11765.11761617882;11782.587609433629;21497.892510537346;21506.354809355744;21510.78489215119;21517.246896358552;21526.56946861054;8485.618147183392;8486.957565212135;8608.741737747878;8724.34567407447;8734.388592798443;4662.347271382009;4705.905881882343;4814.470408255089;4825.662203645711;5017.8243761468175;3451.5685539307588;3539.3806083935724;3551.662592053751;3709.647583479565;3881.844726210976;674.6828990374516;685.3763075601179;687.3367200651295;689.6551724137931;695.7251885505198;639.587466084373;672.2705864137465;704.7286794584122;747.6710247491086;783.6873980090313;10448.791024179474;10449.791004180026;10719.638681828186;10873.836892446461;10899.509522071527;629.8708764703225;667.7929841749074;692.9237783843773;706.8056284521695;759.4645774728803;4982.352294201731;5057.898842023139;5082.771275292621;5186.222066690027;5200.531952124327;122719;125858;129524;131827.34086329507;132884.33557832148;109961.8045834489;111487.44256278829;112723.43638281756;113470;113753;97756;98453.50773246231;99600.8213388215;100912;100962;9748.317617766972;9882.258830587878;9899.1585715215;10009.799804004026;10037.598496060367;54413.72793136009;55149.72425137849;56311;56586.71706641441;57664.71167644135;51979;57160;61767;67979.3202067973;70068.03397720233;12637.810432843698;13044.934775326063;13115.540956066874;13398.26309552945;13715.382807773474;13990.510332138327;14961.925190373979;15090.54728358151;15901.920490397473;15950.361985520449;14607.634809129857;14760.772822636627;14839.470424049026;15067.773983390478;15142;13851.16892986424;14109.475019322716;14518.20149891766;14872.33074511628;15092.019018763745;13976.650583735487;13991.860081399056;14426.567202983928;14504.492342767953;15677.764833527279;11222;11248.94375528117;11521.539138434704;12417.44121514516;12589.118761686594;11704.824427633763;12199.817002744789;12481.500739970299;12897.871021289668;12922.353882306035 05:39:12 INFO - PROCESS | 26618 | __end_tp_report 05:39:12 INFO - PROCESS | 26618 | __start_cc_report 05:39:12 INFO - PROCESS | 26618 | _x_x_mozilla_cycle_collect,928 05:39:12 INFO - PROCESS | 26618 | __end_cc_report 05:39:12 INFO - PROCESS | 26618 | __startTimestamp1468845552747__endTimestamp 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | ------- Summary: start ------- 05:39:12 INFO - PROCESS | 26618 | Number of tests: 6 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#0] dojo.html Cycles:165 Average:5339.16 Median:5518.31 stddev:605.80 (11.0%) stddev-sans-first:580.42 05:39:12 INFO - PROCESS | 26618 | Values: 3049.7 3068.9 3082.6 3111.9 3147.1 5257.1 5327.4 5346.0 5424.5 5426.2 5327.2 5356.6 5379.6 5398.1 5447.3 4840.8 4868.8 4918.1 4926.1 5043.9 4949.4 4951.1 4986.5 4996.9 5013.6 4763.2 4806.6 4867.7 4910.2 4956.4 4878.1 4881.7 4888.0 4946.4 4975.2 4889.6 4914.0 4918.7 4918.8 4941.5 5168.8 5221.0 5295.8 5297.8 5450.3 5666.3 5706.3 5718.1 5719.4 5721.4 5688.1 5704.7 5732.9 5756.3 5757.4 5247.9 5324.6 5356.7 5374.9 5430.6 5952.8 5957.9 5962.9 5965.8 5969.6 5462.0 5679.4 5706.5 5710.3 5710.5 5686.8 5741.0 5774.8 5833.3 5835.4 5752.7 5755.2 5762.4 5762.9 5803.1 5576.9 5669.3 5802.7 5808.0 5812.7 4361.4 4385.4 4390.6 4423.7 4431.9 3900.6 3903.9 3923.0 3926.4 3953.2 5256.7 5372.1 5380.7 5486.7 5528.1 5726.5 5728.0 5745.0 5756.5 5804.4 5437.4 5448.1 5449.5 5454.2 5455.6 4885.3 4887.3 4932.7 4969.8 5011.1 5912.1 5917.9 5919.0 5931.0 5968.5 5717.2 5722.3 5729.4 5730.1 5731.7 5777.5 5894.5 5922.8 5964.9 5982.4 5686.5 5689.5 5692.8 5693.7 5699.2 5738.7 5801.3 5806.9 5811.9 5812.3 5481.7 5585.1 5638.1 5652.7 5654.9 5634.5 5643.3 5644.9 5646.0 5652.1 5398.1 5518.3 5583.2 5586.7 5587.6 5590.4 5613.5 5616.8 5628.2 5668.9 5485.1 5491.9 5496.9 5497.3 5499.9 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#1] ext.html Cycles:180 Average:58501.77 Median:43377.57 stddev:110965.95 (255.8%) stddev-sans-first:111192.17 05:39:12 INFO - PROCESS | 26618 | Values: 629.3 652.7 661.5 673.3 686.9 43062.6 44746.3 45065.5 48505.5 48554.5 46023.8 46599.3 46608.0 46631.3 46693.5 9029.4 9141.1 9156.8 9174.5 9176.4 8949.9 9041.5 9043.8 9044.4 9045.3 9144.1 9195.6 9198.0 9198.7 9205.9 9016.7 9114.9 9153.9 9160.7 9161.5 8983.8 9061.0 9066.4 9067.0 9095.8 43602.8 43886.0 43962.8 44115.6 44205.3 3561.8 3628.7 3651.8 3726.4 3763.5 31872.0 31942.5 32449.4 32679.3 33308.2 4530.9 4594.6 4627.6 4630.1 4738.7 347394.0 348634.0 349158.0 349682.0 351090.0 61230.0 61442.4 61476.4 61731.7 61817.4 57595.4 64119.4 65535.7 65619.0 72618.0 17480.4 17624.8 17636.1 17640.6 17652.7 12296.3 13374.8 13472.7 13477.6 13483.6 19439.6 19622.5 19927.2 20631.2 20652.5 7078.2 7290.7 7293.6 7309.3 7474.4 1000.7 1053.5 1078.7 1102.3 1127.7 33090.3 33574.3 33710.0 33728.5 34071.5 1139.9 1142.2 1201.8 1226.8 1235.2 17340.1 17916.1 17935.3 17943.4 18023.2 542817.0 544825.0 549487.0 551507.0 552209.0 60194.0 60433.7 60984.4 60988.4 61043.7 1264.7 1346.0 1380.9 1404.7 1426.8 31159.4 34522.0 34728.0 34833.5 34940.5 51463.5 51566.2 52129.0 52166.5 52181.7 322578.0 322986.0 323690.0 323891.0 324557.0 28453.3 28719.4 29002.4 29083.4 30517.7 49759.8 49956.3 50708.7 51500.2 51579.0 41897.0 42066.6 42751.8 43059.4 43152.4 42334.6 42617.0 42744.0 42862.1 43798.3 42855.8 43760.6 43963.6 44070.0 44130.3 35818.8 36729.4 36893.0 37884.6 38029.8 28892.1 29013.7 29022.1 29182.3 29260.9 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#2] jquery.html Cycles:180 Average:29437.71 Median:23749.91 stddev:82191.16 (346.1%) stddev-sans-first:82392.74 05:39:12 INFO - PROCESS | 26618 | Values: 365.6 394.9 399.8 400.8 418.5 14457.0 17862.6 19280.6 19861.2 19863.1 18665.2 18704.5 18876.6 18897.1 18901.4 4114.9 5593.0 5791.2 5791.7 5792.4 6467.3 6611.7 6616.9 6619.5 6619.7 6331.2 6509.4 6546.9 6576.4 6579.6 6306.3 6527.6 6535.5 6543.7 6574.8 5675.9 5692.9 5703.8 5705.6 5706.0 23739.1 23760.8 23937.2 24625.3 24672.1 2526.2 2611.6 2992.3 3111.6 3145.9 14675.3 14883.6 15015.8 15093.0 15177.5 1713.8 1788.5 1790.8 1794.3 1882.0 82170.2 82181.0 84114.6 84890.6 85549.0 10001.4 10100.2 10308.9 10664.3 10691.3 13827.9 13845.9 13912.7 13943.7 13944.4 7973.5 8200.7 8234.0 8271.9 8316.6 8195.3 8202.8 8227.1 8413.2 8425.2 6519.4 6538.8 6656.2 6681.4 6758.4 1763.2 1774.4 1818.9 1838.4 1868.8 1023.6 1046.0 1058.6 1085.2 1091.4 19986.9 20204.5 20292.4 20377.7 20398.4 1015.2 1033.7 1043.3 1045.6 1051.1 10872.0 11596.2 11655.4 11748.9 11760.9 488916.0 498673.0 501819.0 504343.0 504913.0 82525.0 85025.0 86285.6 88025.0 88233.0 1031.1 1053.1 1066.3 1079.5 1080.5 17835.2 18042.3 18368.2 18489.5 18621.2 40907.6 41328.6 41350.4 42145.4 42734.8 54086.5 55772.4 56594.0 56737.7 56804.4 5648.5 6454.9 8032.9 8826.7 8958.5 12574.3 13536.9 13741.3 13937.0 13952.9 12067.0 12236.4 12249.1 12332.8 12688.4 12077.2 12157.8 12190.8 12238.8 12509.4 12255.3 12385.6 12468.1 12480.2 12626.7 7699.7 8068.6 8071.0 8089.0 9094.1 11323.7 11662.7 11682.5 12131.5 12420.9 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#3] mootools.html Cycles:180 Average:5792.43 Median:2433.91 stddev:3334.19 (137.0%) stddev-sans-first:3326.95 05:39:12 INFO - PROCESS | 26618 | Values: 1365.7 1445.8 1514.9 1632.2 1803.4 8289.7 8554.0 8585.4 8870.0 8879.1 8624.8 8805.6 8807.6 8812.4 8827.2 2249.6 2256.5 2258.0 2274.4 2275.2 2286.2 2352.1 2361.1 2370.6 2372.7 2274.5 2282.6 2298.1 2305.3 2313.2 2221.7 2226.4 2235.3 2239.5 2240.6 2266.4 2267.0 2274.9 2277.5 2277.9 8725.0 8773.7 8829.3 8836.5 9041.6 5136.2 5235.2 5242.1 5244.9 5246.7 3248.3 3306.9 3311.4 3334.6 3365.5 1041.8 1061.7 1062.4 1074.1 1076.3 12242.8 12311.2 12341.1 12387.5 12388.9 4261.6 4407.7 4463.5 4536.2 4539.3 9858.8 9881.7 9884.7 9888.6 9896.3 5179.4 5181.0 5182.5 5184.2 5185.1 4245.0 4683.9 4835.1 4840.8 4853.3 3786.6 3805.1 3886.5 3899.2 3917.9 1101.6 1110.4 1116.5 1117.2 1118.2 1007.2 1012.9 1013.9 1030.4 1035.2 5959.6 6112.1 6206.2 6244.8 6309.2 429.0 429.8 430.1 433.7 442.7 4163.7 4390.3 4391.7 4401.9 4425.1 10759.7 11027.7 11056.6 11076.4 11089.5 10426.2 10800.6 10996.5 11007.8 11008.4 8203.5 8247.8 8341.0 8377.5 8402.5 6164.8 6346.5 6367.1 6371.6 6518.8 10188.6 10204.8 10253.5 10312.9 10322.5 9812.8 10076.0 10086.3 10398.5 10480.0 6895.8 7087.5 7098.8 7938.7 8082.5 7698.3 8367.6 8616.5 8623.9 8837.9 7786.5 7794.8 7885.0 7922.2 8019.2 7568.9 7794.7 7900.2 8024.3 8058.4 7229.7 7341.9 7479.3 7488.3 7503.5 4999.1 5118.7 5119.8 5133.2 5216.2 5018.8 5148.5 5182.9 5186.0 5284.2 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#4] prototype.html Cycles:180 Average:4681.36 Median:5307.40 stddev:1375.36 (25.9%) stddev-sans-first:1339.71 05:39:12 INFO - PROCESS | 26618 | Values: 321.0 325.6 333.9 335.7 337.8 5318.1 5385.2 5394.2 5406.0 5408.0 5317.5 5345.8 5347.9 5348.5 5371.8 4087.5 4238.9 4243.4 4245.9 4247.6 4186.9 4246.3 4247.2 4267.9 4273.0 4155.0 4173.7 4197.3 4202.3 4216.3 3943.2 4014.5 4055.7 4073.5 4182.7 3579.1 3643.2 3643.7 3650.9 3653.7 5157.0 5164.6 5189.5 5196.6 5203.9 4750.0 4778.9 4802.6 4808.0 4808.6 5589.9 5609.1 5615.5 5629.9 5630.7 4050.3 4053.6 4057.3 4057.6 4058.7 5687.5 5754.3 5770.6 5824.8 5858.3 4095.1 4104.9 4106.8 4108.0 4114.9 4145.2 4151.7 4152.8 4153.0 4165.1 4499.2 4780.0 4780.5 4783.4 4786.8 5613.9 5638.7 5652.7 5654.3 5655.9 1413.8 1436.0 1441.8 1446.5 1446.5 873.9 927.8 928.3 937.0 940.5 4889.0 4921.6 4928.6 4937.3 4976.6 5085.2 5137.5 5141.8 5145.4 5163.6 4878.1 4917.1 4943.1 5001.8 5153.7 2983.7 3032.6 3043.2 3062.4 3062.8 5919.5 5949.7 5975.5 6032.7 6050.0 5659.5 5852.5 5867.3 5872.5 5957.9 5857.6 5864.0 5887.1 5902.2 5947.5 5607.0 5689.0 5703.1 5729.7 5748.8 5701.8 5736.3 5747.6 5757.5 5763.2 5895.4 5950.8 5954.2 6031.4 6032.9 3987.9 4010.4 4059.7 4062.4 4076.2 5728.8 5737.7 5738.4 5764.5 5773.2 5621.7 5636.3 5657.3 5657.7 5660.5 5420.7 5535.9 5563.4 5612.4 5636.7 5377.8 5502.4 5512.5 5529.9 5575.1 5297.3 5586.0 5594.4 5597.8 5598.4 5481.4 5484.4 5487.6 5495.7 5523.7 05:39:12 INFO - PROCESS | 26618 | 05:39:12 INFO - PROCESS | 26618 | [#5] yui.html Cycles:180 Average:21873.18 Median:3545.52 stddev:32540.11 (917.8%) stddev-sans-first:32592.81 05:39:12 INFO - PROCESS | 26618 | Values: 769.1 781.3 839.7 845.0 850.6 14124.5 14174.3 14484.6 14504.9 14509.5 14348.0 14475.9 14485.3 14514.0 14521.9 686.7 792.0 805.4 828.3 830.0 837.3 837.4 839.7 839.7 839.8 878.0 878.8 879.6 879.8 879.9 703.9 839.2 859.4 862.5 874.7 626.1 626.9 627.1 627.1 627.4 14226.4 14275.9 14280.0 14288.1 14301.3 13815.6 13941.8 14027.9 14082.2 14376.8 12581.4 12669.0 12691.5 12819.9 12958.7 4200.3 4252.6 4317.8 4324.4 4372.3 71044.3 74061.0 74154.3 76245.6 83901.0 11328.2 11457.6 11496.1 11765.1 11782.6 21497.9 21506.4 21510.8 21517.2 21526.6 8485.6 8487.0 8608.7 8724.3 8734.4 4662.3 4705.9 4814.5 4825.7 5017.8 3451.6 3539.4 3551.7 3709.6 3881.8 674.7 685.4 687.3 689.7 695.7 639.6 672.3 704.7 747.7 783.7 10448.8 10449.8 10719.6 10873.8 10899.5 629.9 667.8 692.9 706.8 759.5 4982.4 5057.9 5082.8 5186.2 5200.5 122719.0 125858.0 129524.0 131827.3 132884.3 109961.8 111487.4 112723.4 113470.0 113753.0 97756.0 98453.5 99600.8 100912.0 100962.0 9748.3 9882.3 9899.2 10009.8 10037.6 54413.7 55149.7 56311.0 56586.7 57664.7 51979.0 57160.0 61767.0 67979.3 70068.0 12637.8 13044.9 13115.5 13398.3 13715.4 13990.5 14961.9 15090.5 15901.9 15950.4 14607.6 14760.8 14839.5 15067.8 15142.0 13851.2 14109.5 14518.2 14872.3 15092.0 13976.7 13991.9 14426.6 14504.5 15677.8 11222.0 11248.9 11521.5 12417.4 12589.1 11704.8 12199.8 12481.5 12897.9 12922.4 05:39:12 INFO - PROCESS | 26618 | -------- Summary: end -------- 05:39:12 INFO - PROCESS | 26618 | 05:39:13 INFO - TEST-INFO | 26618: exit 0 05:39:13 INFO - TEST-OK | dromaeo_css | took 1112691ms 05:39:13 INFO - TEST-START | kraken 05:39:13 INFO - operating with platform_type : linux_ 05:39:13 INFO - Initialising browser for kraken test... 05:39:13 INFO - TEST-INFO | started process 26808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTkFew7/profile http://localhost:60508/getInfo.html) 05:39:16 INFO - PROCESS | 26808 | JavaScript error: , line 0: uncaught exception: undefined 05:39:17 INFO - PROCESS | 26808 | __metrics Screen width/height:1600/1200 05:39:17 INFO - PROCESS | 26808 | colorDepth:24 05:39:17 INFO - PROCESS | 26808 | Browser inner width/height: 1024/697 05:39:17 INFO - PROCESS | 26808 | __metrics 05:39:18 INFO - PROCESS | 26808 | 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" 05:39:18 INFO - PROCESS | 26808 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:18 INFO - PROCESS | 26808 | console.error: PushService: 05:39:18 INFO - PROCESS | 26808 | stateChangeProcessEnqueue: Error transitioning state 05:39:18 INFO - PROCESS | 26808 | UnknownError 05:39:19 INFO - TEST-INFO | 26808: exit 0 05:39:19 INFO - Browser initialized. 05:39:19 INFO - Running cycle 1/1 for kraken test... 05:39:19 INFO - TEST-INFO | started process 26892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTkFew7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:30 INFO - PROCESS | 26892 | RSS: Main: 157777920 05:39:30 INFO - PROCESS | 26892 | 05:39:33 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:34 INFO - PROCESS | 26892 | RSS: Main: 217071616 05:39:34 INFO - PROCESS | 26892 | 05:39:36 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-dft) 05:39:37 INFO - PROCESS | 26892 | RSS: Main: 204189696 05:39:37 INFO - PROCESS | 26892 | 05:39:40 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-fft) 05:39:41 INFO - PROCESS | 26892 | RSS: Main: 270888960 05:39:41 INFO - PROCESS | 26892 | 05:39:43 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-oscillator) 05:39:43 INFO - PROCESS | 26892 | RSS: Main: 180752384 05:39:43 INFO - PROCESS | 26892 | 05:39:46 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:46 INFO - PROCESS | 26892 | RSS: Main: 185020416 05:39:46 INFO - PROCESS | 26892 | 05:39:49 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:50 INFO - PROCESS | 26892 | RSS: Main: 219254784 05:39:50 INFO - PROCESS | 26892 | 05:39:53 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:54 INFO - PROCESS | 26892 | RSS: Main: 221728768 05:39:54 INFO - PROCESS | 26892 | 05:39:56 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60508/tests/kraken/driver.html?testName=json-parse-financial) 05:39:57 INFO - PROCESS | 26892 | RSS: Main: 221884416 05:39:57 INFO - PROCESS | 26892 | 05:39:59 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:59 INFO - PROCESS | 26892 | RSS: Main: 210268160 05:39:59 INFO - PROCESS | 26892 | 05:40:01 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:02 INFO - PROCESS | 26892 | RSS: Main: 215076864 05:40:02 INFO - PROCESS | 26892 | 05:40:04 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:04 INFO - PROCESS | 26892 | RSS: Main: 211132416 05:40:04 INFO - PROCESS | 26892 | 05:40:07 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:07 INFO - PROCESS | 26892 | RSS: Main: 222519296 05:40:07 INFO - PROCESS | 26892 | 05:40:10 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:11 INFO - PROCESS | 26892 | RSS: Main: 222400512 05:40:11 INFO - PROCESS | 26892 | 05:40:12 INFO - PROCESS | 26892 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60508/tests/kraken/driver.html?testName=ai-astar) 05:40:13 INFO - PROCESS | 26892 | RSS: Main: 264888320 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | __start_tp_report 05:40:13 INFO - PROCESS | 26892 | _x_x_mozilla_page_load 05:40:13 INFO - PROCESS | 26892 | _x_x_mozilla_page_load_details 05:40:13 INFO - PROCESS | 26892 | |i|pagename|runs| 05:40:13 INFO - PROCESS | 26892 | |0;ai-astar;103;113;110;111;111;110;112;111;109;110 05:40:13 INFO - PROCESS | 26892 | |1;audio-beat-detection;148;129;120;170;118;120;142;117;148;117 05:40:13 INFO - PROCESS | 26892 | |2;audio-dft;159;160;159;160;161;160;160;160;160;163 05:40:13 INFO - PROCESS | 26892 | |3;audio-fft;75;76;74;114;75;76;75;74;101;74 05:40:13 INFO - PROCESS | 26892 | |4;audio-oscillator;83;83;117;83;84;85;121;84;84;121 05:40:13 INFO - PROCESS | 26892 | |5;imaging-gaussian-blur;116;117;118;116;117;117;116;117;117;117 05:40:13 INFO - PROCESS | 26892 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;146 05:40:13 INFO - PROCESS | 26892 | |7;imaging-desaturate;95;95;97;96;95;95;95;95;95;95 05:40:13 INFO - PROCESS | 26892 | |8;json-parse-financial;51;51;52;52;50;51;53;52;52;50 05:40:13 INFO - PROCESS | 26892 | |9;json-stringify-tinderbox;62;63;63;64;63;62;63;62;63;63 05:40:13 INFO - PROCESS | 26892 | |10;stanford-crypto-aes;77;78;80;76;75;75;74;75;75;78 05:40:13 INFO - PROCESS | 26892 | |11;stanford-crypto-ccm;121;125;119;117;119;118;119;118;180;131 05:40:13 INFO - PROCESS | 26892 | |12;stanford-crypto-pbkdf2;153;158;155;158;156;156;157;157;155;154 05:40:13 INFO - PROCESS | 26892 | |13;stanford-crypto-sha256-iterative;66;66;67;63;62;64;62;63;63;66 05:40:13 INFO - PROCESS | 26892 | __end_tp_report 05:40:13 INFO - PROCESS | 26892 | __start_cc_report 05:40:13 INFO - PROCESS | 26892 | _x_x_mozilla_cycle_collect,1663 05:40:13 INFO - PROCESS | 26892 | __end_cc_report 05:40:13 INFO - PROCESS | 26892 | __startTimestamp1468845613002__endTimestamp 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | ------- Summary: start ------- 05:40:13 INFO - PROCESS | 26892 | Number of tests: 14 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.71 (2.4%) stddev-sans-first:1.20 05:40:13 INFO - PROCESS | 26892 | Values: 103.0 113.0 110.0 111.0 111.0 110.0 112.0 111.0 109.0 110.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:135.50 stddev:18.23 (13.5%) stddev-sans-first:18.50 05:40:13 INFO - PROCESS | 26892 | Values: 148.0 129.0 120.0 170.0 118.0 120.0 142.0 117.0 148.0 117.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 05:40:13 INFO - PROCESS | 26892 | Values: 159.0 160.0 159.0 160.0 161.0 160.0 160.0 160.0 160.0 163.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.11 (18.8%) stddev-sans-first:14.78 05:40:13 INFO - PROCESS | 26892 | Values: 75.0 76.0 74.0 114.0 75.0 76.0 75.0 74.0 101.0 74.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.50 stddev:17.41 (20.9%) stddev-sans-first:17.96 05:40:13 INFO - PROCESS | 26892 | Values: 83.0 83.0 117.0 83.0 84.0 85.0 121.0 84.0 84.0 121.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:40:13 INFO - PROCESS | 26892 | Values: 116.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:40:13 INFO - PROCESS | 26892 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:40:13 INFO - PROCESS | 26892 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 05:40:13 INFO - PROCESS | 26892 | Values: 51.0 51.0 52.0 52.0 50.0 51.0 53.0 52.0 52.0 50.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:40:13 INFO - PROCESS | 26892 | Values: 62.0 63.0 63.0 64.0 63.0 62.0 63.0 62.0 63.0 63.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.50 stddev:1.89 (2.5%) stddev-sans-first:1.99 05:40:13 INFO - PROCESS | 26892 | Values: 77.0 78.0 80.0 76.0 75.0 75.0 74.0 75.0 75.0 78.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:120.00 stddev:19.20 (16.0%) stddev-sans-first:20.25 05:40:13 INFO - PROCESS | 26892 | Values: 121.0 125.0 119.0 117.0 119.0 118.0 119.0 118.0 180.0 131.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.50 stddev:1.66 (1.1%) stddev-sans-first:1.39 05:40:13 INFO - PROCESS | 26892 | Values: 153.0 158.0 155.0 158.0 156.0 156.0 157.0 157.0 155.0 154.0 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - PROCESS | 26892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:1.87 (2.9%) stddev-sans-first:1.87 05:40:13 INFO - PROCESS | 26892 | Values: 66.0 66.0 67.0 63.0 62.0 64.0 62.0 63.0 63.0 66.0 05:40:13 INFO - PROCESS | 26892 | -------- Summary: end -------- 05:40:13 INFO - PROCESS | 26892 | 05:40:13 INFO - TEST-INFO | 26892: exit 0 05:40:14 INFO - TEST-OK | kraken | took 60541ms 05:40:14 INFO - SUITE-END | took 1173s 05:40:14 INFO - Completed test suite (00:19:33) 05:40:14 INFO - javascript benchmark 05:40:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.6950304969505, 3068.907932762017, 3082.599262095926, 3111.891083812067, 3147.055883235029, 5257.080010998079, 5327.36071671399, 5345.973270133649, 5424.457554244578, 5426.21319908613, 5327.200919862023, 5356.625036247464, 5379.569634429236, 5398.13629819229, 5447.291852059237, 4840.782164802575, 4868.805247790084, 4918.139325618003, 4926.137925862978, 5043.899122017558, 4949.356583644121, 4951.0592987332475, 4986.5013498650205, 4996.875078123039, 5013.623978201631, 4763.2378819388905, 4806.639502037361, 4867.683600565952, 4910.165271903749, 4956.430010548797, 4878.073166098466, 4881.707097574157, 4888.046830867982, 4946.35697359341, 4975.203967365241, 4889.584385327252, 4914.04176185644, 4918.704877707349, 4918.7786549605, 4941.474658976394, 5168.819091331823, 5221.034108689904, 5295.814646487393, 5297.841064768025, 5450.345958484968, 5666.291713535808, 5706.28671416073, 5718.056520674084, 5719.370869204384, 5721.399253078408, 5688.089905615082, 5704.714764261812, 5732.942670573324, 5756.338021127582, 5757.395473475267, 5247.895042099175, 5324.627276090675, 5356.678599284055, 5374.865628359323, 5430.5927055471, 5952.76188952437, 5957.910631340534, 5962.910556341659, 5965.79119730816, 5969.641821490724, 5462.0441422751655, 5679.375268720438, 5706.4864162225595, 5710.2576665033275, 5710.486056254957, 5686.800961966312, 5740.971295143581, 5774.797882074107, 5833.270841144857, 5835.416458354131, 5752.654840709571, 5755.165501002331, 5762.394948530344, 5762.88474230513, 5803.129530570363, 5576.860578485489, 5669.348024977098, 5802.738876750556, 5808.041673123887, 5812.709364531841, 4361.411209486679, 4385.3641222022625, 4390.582894625006, 4423.668224883147, 4431.933520997188, 3900.551436584772, 3903.941440878389, 3922.9803850981134, 3926.3521518949624, 3953.189596132786, 5256.684598924076, 5372.113601255749, 5380.704061276668, 5486.725663716878, 5528.06022976095, 5726.541876649858, 5728.0, 5745.023346031185, 5756.510696590837, 5804.361520232771, 5437.401885792559, 5448.128299472065, 5449.455054494598, 5454.209139674805, 5455.563554915597, 4885.316055752198, 4887.266909963534, 4932.654714170046, 4969.801207951714, 5011.1481048221885, 5912.113183022581, 5917.852053698692, 5918.970405147947, 5930.970345148246, 5968.492678122321, 5717.22817419643, 5722.341930678025, 5729.3984131665575, 5730.054541000688, 5731.656100633975, 5777.537796976148, 5894.528437724886, 5922.822315330547, 5964.880702385841, 5982.4316689914385, 5686.516646085129, 5689.459501347365, 5692.829215123553, 5693.715314234189, 5699.230603868425, 5738.655680659173, 5801.332846722681, 5806.854828629318, 5811.883762324815, 5812.331581868139, 5481.671099734029, 5585.106382978866, 5638.069718496567, 5652.7173641318595, 5654.886902262014, 5634.464725851038, 5643.294588176478, 5644.88710225785, 5646.0, 5652.0674088774895, 5398.13629819227, 5518.310211223597, 5583.218349431002, 5586.692731899784, 5587.608867379245, 5590.413006634245, 5613.494785469327, 5616.831495055155, 5628.1557766333735, 5668.858278542904, 5485.067538518541, 5491.945080549143, 5496.917546236889, 5497.312835895513, 5499.890002200013], "value": 5298.127550981427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.288903539001, 652.7225928980182, 661.4741280681858, 673.2762280548411, 686.9416099631532, 43062.56937430629, 44746.32880506791, 45065.549344506544, 48505.51494485054, 48554.51445485544, 46023.769881150634, 46599.30101048487, 46608.0, 46631.300530492066, 46693.53306466934, 9029.413088149266, 9141.085891410872, 9156.816863662723, 9174.495402752846, 9176.449413035205, 8949.910500895005, 9041.547922603877, 9043.819123617524, 9044.3668943174, 9045.276377889753, 9144.08559144087, 9195.586198621078, 9197.954010229972, 9198.678046268382, 9205.907940920606, 9016.729498115066, 9114.908850911472, 9153.908460915438, 9160.679376221868, 9161.450312981242, 8983.82032359349, 9061.0, 9066.410683305565, 9067.0, 9095.772605684844, 43602.78198608987, 43886.0, 43962.78018609918, 44115.55884441147, 44205.336919946225, 3561.786292822439, 3628.6601641182187, 3651.8174091295327, 3726.366517691999, 3763.5295588051495, 31872.0, 31942.520862187084, 32449.351012979845, 32679.346413071606, 33308.167295817795, 4530.93203601943, 4594.558182934069, 4627.583517483409, 4630.073985202973, 4738.739369334685, 347394.0, 348634.0, 349158.0, 349682.0, 351090.0, 61230.0, 61442.38557614456, 61476.38523614706, 61731.691341543, 61817.38182618206, 57595.42404575984, 64119.358806411336, 65535.67232163904, 65619.0, 72618.0, 17480.388186413413, 17624.823751762317, 17636.118194090242, 17640.647187056442, 17652.735208971877, 12296.262224266573, 13374.799378009338, 13472.663183420493, 13477.595672129852, 13483.595492135251, 19439.611207775764, 19622.5471816023, 19927.202911883363, 20631.17475301001, 20652.48368790762, 7078.1506219254015, 7290.744823931243, 7293.635318234067, 7309.342159205697, 7474.439417043744, 1000.7197984564334, 1053.510117795229, 1078.6925726168004, 1102.3000394749392, 1127.6504283672089, 33090.338193236, 33574.328513429595, 33710.0, 33728.49407258893, 34071.488927666105, 1139.9316041037564, 1142.1662186603826, 1201.7656556971306, 1226.834377359063, 1235.1909499277988, 17340.132993350282, 17916.10419479021, 17935.282588696566, 17943.39068003929, 18023.18895649699, 542817.0, 544825.0, 549487.0, 551507.0, 552209.0, 60194.0, 60433.69783151056, 60984.39015609787, 60988.39011609916, 61043.69478152581, 1264.7470505898673, 1345.9932700336435, 1380.9240491773048, 1404.676924307415, 1426.8073810035512, 31159.376812464077, 34522.0, 34728.0, 34833.47749783806, 34940.47589286112, 51463.48536514737, 51566.22650660168, 52129.0, 52166.47833521616, 52181.7390913043, 322578.0, 322986.0, 323690.0, 323891.0, 324557.0, 28453.288667783472, 28719.42561148807, 29002.41995160127, 29083.41833163367, 30517.694823052374, 49759.751201243766, 49956.250656239456, 50708.74645626748, 51500.22749658833, 51579.0, 41897.0, 42066.57933420627, 42751.78624106859, 43059.354109689004, 43152.35271470868, 42334.57665423306, 42617.0, 42744.0, 42862.14275714531, 43798.34302485402, 42855.785721071195, 43760.562394376924, 43963.56036439595, 44070.0, 44130.338044929995, 35818.82090589531, 36729.44905826361, 36893.0, 37884.62115378921, 38029.809850950565, 28892.133236002952, 29013.709862901946, 29022.12933611995, 29182.27044323909, 29260.853695731385], "value": 20749.53885577596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.581409286367, 394.8775879477361, 399.8480577380593, 400.8276441130314, 418.474814108294, 14456.957851666468, 17862.553436164104, 19280.614387712274, 19861.20555177793, 19863.10616022279, 18665.160067796947, 18704.532386690338, 18876.622467550642, 18897.055147242616, 18901.43295701128, 4114.876553703379, 5592.99999999999, 5791.218185544961, 5791.681457519835, 5792.420757924216, 6467.256265529477, 6611.669416529155, 6616.867662646744, 6619.536632435731, 6619.669016549154, 6331.2085989251345, 6509.4466970307585, 6546.9017964730565, 6576.375244351779, 6579.60522368657, 6306.274778400497, 6527.640979746136, 6535.54251202416, 6543.672816359187, 6574.835629109287, 5675.914861277084, 5692.9146062809095, 5703.77184912603, 5705.6006079574445, 5706.029974904276, 23739.05043798246, 23760.76239237603, 23937.162199322942, 24625.261242162764, 24672.13647522328, 2526.2295000024983, 2611.6082587611822, 2992.2968102495897, 3111.579936708538, 3145.874165033396, 14675.266236688123, 14883.553493395108, 15015.774763378558, 15093.0, 15177.544673659808, 1713.7943446786342, 1788.5260405992422, 1790.7672002639574, 1794.3223086414243, 1881.9623607527774, 82170.17829821745, 82181.0, 84114.57942710309, 84890.57554712248, 85549.0, 10001.399916005063, 10100.191984641211, 10308.896911030793, 10664.253502254924, 10691.251612387214, 13827.930860345836, 13845.930770346084, 13912.652183695287, 13943.721125577635, 13944.442222311196, 7973.481723687942, 8200.712975045844, 8234.0, 8271.875921861178, 8316.625751841182, 8195.262426381654, 8202.835943281101, 8227.053888802864, 8413.15868413166, 8425.157484251526, 6519.4132528072705, 6538.803835884836, 6656.167979002625, 6681.365270299314, 6758.357955994173, 1763.1713094845402, 1774.378967361439, 1818.8908665479848, 1838.3841413126752, 1868.831805137544, 1023.6161439460202, 1045.9633912813015, 1058.640062378795, 1085.1698450685233, 1091.410638255349, 19986.90006549958, 20204.494887627632, 20292.391228263175, 20377.694334584994, 20398.388048358574, 1015.1574193419444, 1033.7260625934134, 1043.3062013760764, 1045.5869931377215, 1051.1433181956681, 10872.0, 11596.246243994114, 11655.41722913851, 11748.88251117495, 11760.88239117598, 488916.0, 498673.0, 501819.0, 504343.0, 504913.0, 82525.0, 85025.0, 86285.56857215674, 88025.0, 88233.0, 1031.1493018259816, 1053.1259054984343, 1066.3122286125406, 1079.4764539198482, 1080.5407701726735, 17835.197416116047, 18042.2783088675, 18368.173432195315, 18489.53776155607, 18621.162047707614, 40907.59092409038, 41328.58671413368, 41350.37974430446, 42145.36781948212, 42734.786326069414, 54086.45913540814, 55772.44227557672, 56594.0, 56737.71631141983, 56804.43195567992, 5648.4633959773755, 6454.903176452451, 8032.919670803217, 8826.735197944072, 8958.462492250486, 12574.30841303737, 13536.932315338361, 13741.312934353442, 13936.961834273627, 13952.930235348758, 12067.0, 12236.449359778653, 12249.08131890094, 12332.81500777507, 12688.429020693906, 12077.214981026205, 12157.756844862877, 12190.817137742764, 12238.816417753918, 12509.437075331814, 12255.32595707209, 12385.566505172275, 12468.127231093737, 12480.188787728768, 12626.747465050832, 7699.6535155917, 8068.636911338886, 8070.959645201971, 8089.0, 9094.136057074567, 11323.716907077389, 11662.650120496399, 11682.4742886572, 12131.454084566392, 12420.875791241971], "value": 9566.092666335539, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.6790654196268, 1445.7903603977427, 1514.8788096952244, 1632.2165360626898, 1803.4138904855918, 8289.66841326347, 8554.0, 8585.441946273495, 8870.0, 8879.067697891725, 8624.784380390493, 8805.64777408903, 8807.603657835396, 8812.38313318068, 8827.161419665137, 2249.6175650139476, 2256.4810093678466, 2257.9661305080435, 2274.442761523429, 2275.1923067311113, 2286.222684287342, 2352.070931981866, 2361.0791791201445, 2370.6444033394955, 2372.7389987101405, 2274.5109801392696, 2282.6233671444193, 2298.069281940817, 2305.2853615379204, 2313.155698170164, 2221.6556433752794, 2226.376614547929, 2235.251190851067, 2239.4625289930464, 2240.63029600115, 2266.3994041578994, 2266.9886650566805, 2274.8748818814956, 2277.5331057133412, 2277.920272790461, 8724.956375218084, 8773.736787896374, 8829.337799664987, 8836.513991730451, 9041.593128309176, 5136.203888397305, 5235.214717792323, 5242.1088414969545, 5244.8688782780355, 5246.737663116867, 3248.2691394436297, 3306.9007929762147, 3311.3708395404797, 3334.61651910031, 3365.4951757236367, 1041.8020576090519, 1061.7239517725448, 1062.4422178356347, 1074.1460538871615, 1076.3272954403499, 12242.81635775464, 12311.19977201479, 12341.07441941849, 12387.504499820086, 12388.876111238953, 4261.616454519108, 4407.713498622579, 4463.531329210451, 4536.206163921301, 4539.273716205391, 9858.802823943624, 9881.654142105135, 9884.703458896101, 9888.604455821687, 9896.307258491837, 5179.352580927384, 5180.974095129575, 5182.481751824863, 5184.248283998874, 5185.144451165591, 4244.957550424456, 4683.882902927386, 4835.1296766581645, 4840.83057093, 4853.320535125085, 3786.6024067473068, 3805.0867791729784, 3886.514185726784, 3899.200663863901, 3917.941230881539, 1101.553870682375, 1110.3781882146025, 1116.5031560955297, 1117.2458590451413, 1118.1837258800958, 1007.2395341517108, 1012.8632634594383, 1013.9239557033252, 1030.4126647810676, 1035.2028937718067, 5959.5828292020005, 6112.144299798032, 6206.162168107338, 6244.75020999164, 6309.2428908530355, 428.9742615443083, 429.76363000350307, 430.07104653947323, 433.741923555484, 442.7498463368187, 4163.666906647461, 4390.319500477431, 4391.736495810262, 4401.911961760811, 4425.070735145591, 10759.731006724738, 11027.724306892393, 11056.557737690402, 11076.446177691083, 11089.500972456259, 10426.218033647507, 10800.567977280822, 10996.450177491093, 11007.834882476769, 11008.39453830031, 8203.466774659628, 8247.752567422987, 8341.04078031022, 8377.49735015901, 8402.495850248883, 6164.753409863555, 6346.492280617447, 6367.140436041075, 6371.617702937839, 6518.771842985473, 10188.592456301962, 10204.846927295948, 10253.538590763284, 10312.896871031493, 10322.48387580633, 9812.803743924938, 10076.042775936274, 10086.344387614781, 10398.480075996322, 10480.0, 6895.827604309932, 7087.539309944837, 7098.787036388917, 7938.722144724907, 8082.515049097073, 7698.2686644768655, 8367.623456944573, 8616.48301101936, 8623.913760862311, 8837.91162088371, 7786.4938778979185, 7794.844103118019, 7884.960575197088, 7922.247386498273, 8019.238172373615, 7568.886466703114, 7794.688212471665, 7900.222449948716, 8024.277814996678, 8058.355331573577, 7229.710811567478, 7341.853162936604, 7479.326860582573, 7488.326050655467, 7503.5497870127965, 4999.10016197088, 5118.74406279692, 5119.846404607868, 5133.153029750049, 5216.243644671577, 5018.799248030038, 5148.459411761711, 5182.922256166085, 5185.974070129625, 5284.154535274338], "value": 4524.3253315451775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9985738917848, 325.56862157641126, 333.8664534186325, 335.7247057412919, 337.8142021887961, 5318.095923692972, 5385.165299378593, 5394.1908713692965, 5405.972970135149, 5407.972960135204, 5317.46825317468, 5345.812896548621, 5347.946520534793, 5348.5453736432355, 5371.818199996004, 4087.4686290782306, 4238.936415953764, 4243.427137336451, 4245.893852653693, 4247.638950689196, 4186.853460128896, 4246.299360605496, 4247.193033323674, 4267.935980960288, 4272.978635106821, 4155.005597313277, 4173.749575025508, 4197.313719219686, 4202.348635961431, 4216.325387937931, 3943.2310699413624, 4014.498187726534, 4055.695822813271, 4073.5111786585503, 4182.707210495267, 3579.1231148368556, 3643.1802844360072, 3643.653852883972, 3650.945235821465, 3653.7077033837495, 5156.9742151289, 5164.6384753067305, 5189.481051894818, 5196.584273258168, 5203.895922081537, 4750.0, 4778.880527986794, 4802.567768900815, 4808.01435705683, 4808.61531077513, 5589.888202235973, 5609.1305847593685, 5615.522680572156, 5629.887402251973, 5630.690312032836, 4050.2709512287774, 4053.61490658387, 4057.310257256244, 4057.5942405759483, 4058.7271128168322, 5687.544996400278, 5754.280714910637, 5770.596058275923, 5824.825255242349, 5858.297004359504, 4095.119549296856, 4104.850641820295, 4106.7535947842625, 4108.014076621649, 4114.897127571775, 4145.17096580685, 4151.73013754105, 4152.771597562163, 4152.958470415258, 4165.146145040259, 4499.212637788374, 4780.0, 4780.490242622651, 4783.4499032611, 4786.7845946932475, 5613.905288468791, 5638.718064096779, 5652.660840349592, 5654.264945557051, 5655.886882262332, 1413.7949997250341, 1435.992820035914, 1441.80535627691, 1446.4720377062297, 1446.5443385333585, 873.9082396348292, 927.8051609162152, 928.2759447630858, 936.9531523423801, 940.47333493244, 4889.0, 4921.581665558396, 4928.605711543068, 4937.308776771255, 4976.62675299354, 5085.211792172219, 5137.460566640524, 5141.794328226903, 5145.434002259748, 5163.586913047023, 4878.121938051114, 4917.065757506062, 4943.132982869927, 5001.824936127218, 5153.6907785532985, 2983.686712895158, 3032.605761251067, 3043.239190202449, 3062.4487592233168, 3062.785605007628, 5919.4968427684125, 5949.732262048218, 5975.52195824333, 6032.728527216198, 6050.0, 5659.518940889988, 5852.473277405054, 5867.295924489089, 5872.471477567039, 5957.851053723605, 5857.648541087548, 5863.970680146572, 5887.087501437284, 5902.2327097477055, 5947.464728174485, 5607.0, 5689.0, 5703.116017017369, 5729.656220626775, 5748.798792042258, 5701.771929122789, 5736.282964629421, 5747.620571062998, 5757.481826635623, 5763.242211125647, 5895.380984996686, 5950.761969521171, 5954.225950626565, 6031.366706495754, 6032.939670603413, 3987.892470755127, 4010.438538604539, 4059.6752259818554, 4062.431259623596, 4076.2255171517318, 5728.770849165987, 5737.74180161902, 5738.364566098642, 5764.481196692318, 5773.162891380643, 5621.7189140542, 5636.323641162922, 5657.264555607745, 5657.717114144359, 5660.490555849993, 5420.674759514442, 5535.916961245504, 5563.388027316911, 5612.382637909745, 5636.689982051026, 5377.758000889891, 5502.422245664307, 5512.503874651301, 5529.917051244154, 5575.104464482096, 5297.337832770903, 5585.989043944258, 5594.41258667834, 5597.80407685729, 5598.440155984369, 5481.410390986569, 5484.424135465878, 5487.64330318528, 5495.670259784426, 5523.6685798852195], "value": 4241.230185179062, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.1385648074158, 781.2888283649593, 839.7019058234325, 845.0, 850.591715976331, 14124.505642302509, 14174.291285435713, 14484.637884052903, 14504.854951450483, 14509.49216777413, 14348.0, 14475.855241447582, 14485.348159332829, 14514.0, 14521.927390363033, 686.6566716641679, 791.9762407127795, 805.4402190477621, 828.3456069704926, 830.016430529821, 837.2673910328463, 837.3552364679193, 839.7144970709958, 839.7354833227545, 839.7942504086508, 877.9561021948876, 878.8110556230409, 879.5953861223845, 879.8020445399798, 879.8768172455862, 703.9190493093308, 839.215333663027, 859.3726579596866, 862.4738909265343, 874.6632546469623, 626.0515319291277, 626.9498440124825, 627.0531497438855, 627.0594108836744, 627.4447114303829, 14226.430942762277, 14275.928620356935, 14280.0, 14288.142711437347, 14301.284935753274, 13815.585532434043, 13941.790873136912, 14027.929860350734, 14082.225477598728, 14376.784348234785, 12581.433835477334, 12668.95579858281, 12691.492340306377, 12819.871801282054, 12958.676033099153, 4200.306949353353, 4252.596003379674, 4317.775571002979, 4324.416203812508, 4372.256716358227, 71044.28955710429, 74061.0, 74154.25845741581, 76245.61877190579, 83900.99999999939, 11328.150388720878, 11457.59898403552, 11496.137789665809, 11765.11761617882, 11782.587609433629, 21497.892510537346, 21506.354809355744, 21510.78489215119, 21517.246896358552, 21526.56946861054, 8485.618147183392, 8486.957565212135, 8608.741737747878, 8724.34567407447, 8734.388592798443, 4662.347271382009, 4705.905881882343, 4814.470408255089, 4825.662203645711, 5017.8243761468175, 3451.5685539307588, 3539.3806083935724, 3551.662592053751, 3709.647583479565, 3881.844726210976, 674.6828990374516, 685.3763075601179, 687.3367200651295, 689.6551724137931, 695.7251885505198, 639.587466084373, 672.2705864137465, 704.7286794584122, 747.6710247491086, 783.6873980090313, 10448.791024179474, 10449.791004180026, 10719.638681828186, 10873.836892446461, 10899.509522071527, 629.8708764703225, 667.7929841749074, 692.9237783843773, 706.8056284521695, 759.4645774728803, 4982.352294201731, 5057.898842023139, 5082.771275292621, 5186.222066690027, 5200.531952124327, 122719.0, 125858.0, 129524.0, 131827.34086329507, 132884.33557832148, 109961.8045834489, 111487.44256278829, 112723.43638281756, 113470.0, 113753.0, 97756.0, 98453.50773246231, 99600.8213388215, 100912.0, 100962.0, 9748.317617766972, 9882.258830587878, 9899.1585715215, 10009.799804004026, 10037.598496060367, 54413.72793136009, 55149.72425137849, 56311.0, 56586.71706641441, 57664.71167644135, 51979.0, 57160.0, 61767.0, 67979.3202067973, 70068.03397720233, 12637.810432843698, 13044.934775326063, 13115.540956066874, 13398.26309552945, 13715.382807773474, 13990.510332138327, 14961.925190373979, 15090.54728358151, 15901.920490397473, 15950.361985520449, 14607.634809129857, 14760.772822636627, 14839.470424049026, 15067.773983390478, 15142.0, 13851.16892986424, 14109.475019322716, 14518.20149891766, 14872.33074511628, 15092.019018763745, 13976.650583735487, 13991.860081399056, 14426.567202983928, 14504.492342767953, 15677.764833527279, 11222.0, 11248.94375528117, 11521.539138434704, 12417.44121514516, 12589.118761686594, 11704.824427633763, 12199.817002744789, 12481.500739970299, 12897.871021289668, 12922.353882306035], "value": 7805.500510431715, "unit": "score"}], "name": "dromaeo_css", "value": 7348.972152220723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 111.0, 111.0, 110.0, 112.0, 111.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 120.0, 170.0, 118.0, 120.0, 142.0, 117.0, 148.0, 117.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 163.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 114.0, 75.0, 76.0, 75.0, 74.0, 101.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 84.0, 85.0, 121.0, 84.0, 84.0, 121.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 50.0, 51.0, 53.0, 52.0, 52.0, 50.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 80.0, 76.0, 75.0, 75.0, 74.0, 75.0, 75.0, 78.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 125.0, 119.0, 117.0, 119.0, 118.0, 119.0, 118.0, 180.0, 131.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 155.0, 158.0, 156.0, 156.0, 157.0, 157.0, 155.0, 154.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 66.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1474.3, "alertThreshold": 2.0}]} 05:40:14 INFO - Return code: 0 05:40:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:40:14 INFO - # TBPL SUCCESS # 05:40:14 INFO - Running post-action listener: _resource_record_post_action 05:40:14 INFO - ##### 05:40:14 INFO - ##### Finished run-tests step (success) 05:40:14 INFO - ##### 05:40:14 INFO - Running post-run listener: _resource_record_post_run 05:40:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 558567424; Read time: 0; Write time: 507840 05:40:14 INFO - TinderboxPrint: CPU usage
13.0% 05:40:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:40:14 INFO - TinderboxPrint: I/O write bytes / time
558,567,424 / 507,840 05:40:14 INFO - TinderboxPrint: CPU idle
8,266.7 (87.0%) 05:40:14 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 05:40:14 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:14 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260972544; Read time: 0; Write time: 280956 05:40:14 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297594880; Read time: 0; Write time: 226884 05:40:14 INFO - Running post-run listener: _upload_blobber_files 05:40:14 INFO - Blob upload gear active. 05:40:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:14 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 05:40:14 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'] 05:40:14 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 05:40:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:40:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:17 INFO - (blobuploader) - INFO - Done attempting. 05:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:18 INFO - (blobuploader) - INFO - Done attempting. 05:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:22 INFO - (blobuploader) - INFO - Done attempting. 05:40:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:22 INFO - Return code: 0 05:40:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf3bdced86e63a9e113a9c516075120ae2e41c1508776d19eb6a06160a0c2d4ecb36af7ae6b131b7896e5040f535f75efa5c200e11a263625fc7c63e4d333246", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/789bf97c6e1f5866dfcbcdedd96b18e776b5aeee79c428b50514d131a4166c8cf2bd52e2ab9ca501f7ac6ec1918779cfe6c8bd028d9f520b0a8084aa1933e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d76d41300090baf22d7e03dc20364de7c2c5a5171923f4fd10c6bf2b1b7e761e87602d2323b0c21a5fc29dc7cacd19fb7a0e76f321959b009d744792c3fe962f"} 05:40:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:22 INFO - Contents: 05:40:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf3bdced86e63a9e113a9c516075120ae2e41c1508776d19eb6a06160a0c2d4ecb36af7ae6b131b7896e5040f535f75efa5c200e11a263625fc7c63e4d333246", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/789bf97c6e1f5866dfcbcdedd96b18e776b5aeee79c428b50514d131a4166c8cf2bd52e2ab9ca501f7ac6ec1918779cfe6c8bd028d9f520b0a8084aa1933e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d76d41300090baf22d7e03dc20364de7c2c5a5171923f4fd10c6bf2b1b7e761e87602d2323b0c21a5fc29dc7cacd19fb7a0e76f321959b009d744792c3fe962f"} 05:40:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:22 INFO - Copying logs to upload dir... 05:40:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.388675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-18 05:40:21.947297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:40:21.950325) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 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/bf3bdced86e63a9e113a9c516075120ae2e41c1508776d19eb6a06160a0c2d4ecb36af7ae6b131b7896e5040f535f75efa5c200e11a263625fc7c63e4d333246", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/789bf97c6e1f5866dfcbcdedd96b18e776b5aeee79c428b50514d131a4166c8cf2bd52e2ab9ca501f7ac6ec1918779cfe6c8bd028d9f520b0a8084aa1933e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d76d41300090baf22d7e03dc20364de7c2c5a5171923f4fd10c6bf2b1b7e761e87602d2323b0c21a5fc29dc7cacd19fb7a0e76f321959b009d744792c3fe962f"} build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/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/bf3bdced86e63a9e113a9c516075120ae2e41c1508776d19eb6a06160a0c2d4ecb36af7ae6b131b7896e5040f535f75efa5c200e11a263625fc7c63e4d333246", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/789bf97c6e1f5866dfcbcdedd96b18e776b5aeee79c428b50514d131a4166c8cf2bd52e2ab9ca501f7ac6ec1918779cfe6c8bd028d9f520b0a8084aa1933e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d76d41300090baf22d7e03dc20364de7c2c5a5171923f4fd10c6bf2b1b7e761e87602d2323b0c21a5fc29dc7cacd19fb7a0e76f321959b009d744792c3fe962f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:40:21.975655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:40:21.975982) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468844390.290892-141331725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004346 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:40:22.060389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:40:22.060906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:40:22.061424) ========= ========= Total master_lag: 0.17 =========