builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1470563965.98 results: success (0) buildid: 20160807001853 builduid: 8d764c5a7a4245729e13375ab54726ee revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:25.986118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:25.986718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:25.986996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.004127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.004422) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 02:59:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-08-07 02:59:26 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172867 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.341543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.341853) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017334 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.378484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:26.378823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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 d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 02:59:26,497 truncating revision to first 12 chars 2016-08-07 02:59:26,497 Setting DEBUG logging. 2016-08-07 02:59:26,497 attempt 1/10 2016-08-07 02:59:26,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 02:59:26,809 unpacking tar archive at: fx-team-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640714 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:27.240541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:27.240820) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:27.241220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:27.241482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 02:59:27.266957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-07 02:59:27.267219) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:27 INFO - MultiFileLogger online at 20160807 02:59:27 in /builds/slave/test 02:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:27 INFO - {'append_to_log': False, 02:59:27 INFO - 'base_work_dir': '/builds/slave/test', 02:59:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:27 INFO - 'branch': 'Fx-Team-Non-PGO', 02:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:27 INFO - 'config_files': ('talos/linux_config.py',), 02:59:27 INFO - 'default_actions': ('clobber', 02:59:27 INFO - 'read-buildbot-config', 02:59:27 INFO - 'download-and-extract', 02:59:27 INFO - 'populate-webroot', 02:59:27 INFO - 'create-virtualenv', 02:59:27 INFO - 'install', 02:59:27 INFO - 'run-tests'), 02:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:27 INFO - 'download_minidump_stackwalk': True, 02:59:27 INFO - 'download_symbols': 'ondemand', 02:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:27 INFO - 'installer_path': 'installer.exe', 02:59:27 INFO - 'log_level': 'info', 02:59:27 INFO - 'log_name': 'talos', 02:59:27 INFO - 'log_to_console': True, 02:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:27 INFO - 'opt_config_files': (), 02:59:27 INFO - 'pip_index': False, 02:59:27 INFO - 'sps_profile': False, 02:59:27 INFO - 'sps_profile_interval': 0, 02:59:27 INFO - 'suite': 'dromaeojs', 02:59:27 INFO - 'system_bits': '32', 02:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:27 INFO - 'title': 'talos-linux64-ix-030', 02:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:27 INFO - 'use_talos_json': True, 02:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:27 INFO - 'work_dir': 'build'} 02:59:27 INFO - [mozharness: 2016-08-07 09:59:27.477559Z] Running clobber step. 02:59:27 INFO - Running pre-action listener: _resource_record_pre_action 02:59:27 INFO - Running main action method: clobber 02:59:27 INFO - rmtree: /builds/slave/test/build 02:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:27 INFO - Running post-action listener: _resource_record_post_action 02:59:27 INFO - [mozharness: 2016-08-07 09:59:27.934390Z] Finished clobber step (success) 02:59:27 INFO - [mozharness: 2016-08-07 09:59:27.934491Z] Running read-buildbot-config step. 02:59:27 INFO - Running pre-action listener: _resource_record_pre_action 02:59:27 INFO - Running main action method: read_buildbot_config 02:59:27 INFO - Using buildbot properties: 02:59:27 INFO - { 02:59:27 INFO - "project": "", 02:59:27 INFO - "product": "firefox", 02:59:27 INFO - "script_repo_revision": "production", 02:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:59:27 INFO - "repository": "", 02:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:59:27 INFO - "buildid": "20160807001853", 02:59:27 INFO - "pgo_build": "False", 02:59:27 INFO - "basedir": "/builds/slave/test", 02:59:27 INFO - "buildnumber": 2073, 02:59:27 INFO - "slavename": "talos-linux64-ix-030", 02:59:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:59:27 INFO - "platform": "ubuntu64_hw", 02:59:27 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 02:59:27 INFO - "branch": "fx-team", 02:59:27 INFO - "repo_path": "integration/fx-team", 02:59:27 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 02:59:27 INFO - "stage_platform": "linux64", 02:59:27 INFO - "builduid": "8d764c5a7a4245729e13375ab54726ee", 02:59:27 INFO - "slavebuilddir": "test" 02:59:27 INFO - } 02:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:59:27 INFO - Running post-action listener: _resource_record_post_action 02:59:27 INFO - [mozharness: 2016-08-07 09:59:27.936934Z] Finished read-buildbot-config step (success) 02:59:27 INFO - [mozharness: 2016-08-07 09:59:27.937023Z] Running download-and-extract step. 02:59:27 INFO - Running pre-action listener: _resource_record_pre_action 02:59:27 INFO - Running main action method: download_and_extract 02:59:27 INFO - mkdir: /builds/slave/test/build/tests 02:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:27 INFO - trying https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:59:27 INFO - Downloading https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:59:28 INFO - Downloaded 1361 bytes. 02:59:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:59:28 INFO - Using the following test package requirements: 02:59:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:59:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:59:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'jsshell-linux-x86_64.zip'], 02:59:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:59:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:59:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:59:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:59:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:59:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:59:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:28 INFO - trying https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:59:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:29 INFO - Downloaded 20257652 bytes. 02:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:59:30 INFO - Return code: 0 02:59:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:30 INFO - trying https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:59:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:32 INFO - Downloaded 20257652 bytes. 02:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:59:33 INFO - Return code: 0 02:59:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:33 INFO - trying https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:33 INFO - Downloading https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:59:34 INFO - Downloaded 14413723 bytes. 02:59:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:59:35 INFO - Return code: 0 02:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:35 INFO - trying https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:59:35 INFO - Downloading https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:59:36 INFO - Downloaded 56130508 bytes. 02:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:59:36 INFO - mkdir: /builds/slave/test/properties 02:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:36 INFO - Contents: 02:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:59:37 INFO - Running post-action listener: _resource_record_post_action 02:59:37 INFO - Running post-action listener: set_extra_try_arguments 02:59:37 INFO - [mozharness: 2016-08-07 09:59:37.354487Z] Finished download-and-extract step (success) 02:59:37 INFO - [mozharness: 2016-08-07 09:59:37.354719Z] Running populate-webroot step. 02:59:37 INFO - Running pre-action listener: _resource_record_pre_action 02:59:37 INFO - Running main action method: populate_webroot 02:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:37 INFO - '--tppagecycles', 02:59:37 INFO - '7'], 02:59:37 INFO - 'tests': ['tsvgm']}}, 02:59:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['damp', 'tps']}, 02:59:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'tests': ['damp', 'tps']}, 02:59:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['dromaeo_dom']}, 02:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['basic_compositor_video']}, 02:59:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:59:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['a11yr', 02:59:37 INFO - 'ts_paint', 02:59:37 INFO - 'tpaint', 02:59:37 INFO - 'sessionrestore', 02:59:37 INFO - 'sessionrestore_no_auto_restore', 02:59:37 INFO - 'tabpaint']}, 02:59:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['tsvgx', 02:59:37 INFO - 'tsvgr_opacity', 02:59:37 INFO - 'tart', 02:59:37 INFO - 'tscrollx', 02:59:37 INFO - 'cart']}, 02:59:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:37 INFO - 'tsvgr_opacity', 02:59:37 INFO - 'tart', 02:59:37 INFO - 'tscrollx', 02:59:37 INFO - 'cart']}, 02:59:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'talos_options': ['--disable-e10s'], 02:59:37 INFO - 'tests': ['tp5o']}, 02:59:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'tests': ['tp5o']}, 02:59:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'talos_options': ['--disable-e10s', 02:59:37 INFO - '--xperf_path', 02:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:37 INFO - 'tests': ['tp5n']}, 02:59:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:37 INFO - 'talos_options': ['--xperf_path', 02:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:37 INFO - 'tests': ['tp5n']}}, 02:59:37 INFO - 'talos.zip': {'path': '', 02:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:37 INFO - Running post-action listener: _resource_record_post_action 02:59:37 INFO - [mozharness: 2016-08-07 09:59:37.377267Z] Finished populate-webroot step (success) 02:59:37 INFO - [mozharness: 2016-08-07 09:59:37.377373Z] Running create-virtualenv step. 02:59:37 INFO - Running pre-action listener: _resource_record_pre_action 02:59:37 INFO - Running main action method: create_virtualenv 02:59:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:37 INFO - Using real prefix '/usr' 02:59:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:39 INFO - Installing pip.................done. 02:59:39 INFO - Return code: 0 02:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:39 INFO - Using env: {'DISPLAY': ':0', 02:59:39 INFO - 'HOME': '/home/cltbld', 02:59:39 INFO - 'LANG': 'en_US.UTF-8', 02:59:39 INFO - 'LANGUAGE': 'en_US:en', 02:59:39 INFO - 'LOGNAME': 'cltbld', 02:59:39 INFO - 'MAIL': '/var/mail/cltbld', 02:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:39 INFO - 'MOZ_NO_REMOTE': '1', 02:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:39 INFO - 'NO_EM_RESTART': '1', 02:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:39 INFO - 'PWD': '/builds/slave/test', 02:59:39 INFO - 'SHELL': '/bin/bash', 02:59:39 INFO - 'SHLVL': '1', 02:59:39 INFO - 'TERM': 'linux', 02:59:39 INFO - 'TMOUT': '86400', 02:59:39 INFO - 'USER': 'cltbld', 02:59:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:39 INFO - '_': '/tools/buildbot/bin/python'} 02:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:59:40 INFO - Cleaning up... 02:59:40 INFO - Return code: 0 02:59:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:40 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:59:40 INFO - Using env: {'DISPLAY': ':0', 02:59:40 INFO - 'HOME': '/home/cltbld', 02:59:40 INFO - 'LANG': 'en_US.UTF-8', 02:59:40 INFO - 'LANGUAGE': 'en_US:en', 02:59:40 INFO - 'LOGNAME': 'cltbld', 02:59:40 INFO - 'MAIL': '/var/mail/cltbld', 02:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:40 INFO - 'MOZ_NO_REMOTE': '1', 02:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:40 INFO - 'NO_EM_RESTART': '1', 02:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:40 INFO - 'PWD': '/builds/slave/test', 02:59:40 INFO - 'SHELL': '/bin/bash', 02:59:40 INFO - 'SHLVL': '1', 02:59:40 INFO - 'TERM': 'linux', 02:59:40 INFO - 'TMOUT': '86400', 02:59:40 INFO - 'USER': 'cltbld', 02:59:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:40 INFO - '_': '/tools/buildbot/bin/python'} 02:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:40 INFO - Downloading/unpacking psutil>=3.1.1 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:42 INFO - Installing collected packages: psutil 02:59:42 INFO - Running setup.py install for psutil 02:59:42 INFO - building 'psutil._psutil_linux' extension 02:59:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:59:42 INFO - building 'psutil._psutil_posix' extension 02:59:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:42 INFO - Successfully installed psutil 02:59:42 INFO - Cleaning up... 02:59:42 INFO - Return code: 0 02:59:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:42 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:42 INFO - Using env: {'DISPLAY': ':0', 02:59:42 INFO - 'HOME': '/home/cltbld', 02:59:42 INFO - 'LANG': 'en_US.UTF-8', 02:59:42 INFO - 'LANGUAGE': 'en_US:en', 02:59:42 INFO - 'LOGNAME': 'cltbld', 02:59:42 INFO - 'MAIL': '/var/mail/cltbld', 02:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:42 INFO - 'MOZ_NO_REMOTE': '1', 02:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:42 INFO - 'NO_EM_RESTART': '1', 02:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:42 INFO - 'PWD': '/builds/slave/test', 02:59:42 INFO - 'SHELL': '/bin/bash', 02:59:42 INFO - 'SHLVL': '1', 02:59:42 INFO - 'TERM': 'linux', 02:59:42 INFO - 'TMOUT': '86400', 02:59:42 INFO - 'USER': 'cltbld', 02:59:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:42 INFO - '_': '/tools/buildbot/bin/python'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:45 INFO - Installing collected packages: mozsystemmonitor 02:59:45 INFO - Running setup.py install for mozsystemmonitor 02:59:45 INFO - Successfully installed mozsystemmonitor 02:59:45 INFO - Cleaning up... 02:59:45 INFO - Return code: 0 02:59:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:59:45 INFO - Using env: {'DISPLAY': ':0', 02:59:45 INFO - 'HOME': '/home/cltbld', 02:59:45 INFO - 'LANG': 'en_US.UTF-8', 02:59:45 INFO - 'LANGUAGE': 'en_US:en', 02:59:45 INFO - 'LOGNAME': 'cltbld', 02:59:45 INFO - 'MAIL': '/var/mail/cltbld', 02:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:45 INFO - 'MOZ_NO_REMOTE': '1', 02:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:45 INFO - 'NO_EM_RESTART': '1', 02:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:45 INFO - 'PWD': '/builds/slave/test', 02:59:45 INFO - 'SHELL': '/bin/bash', 02:59:45 INFO - 'SHLVL': '1', 02:59:45 INFO - 'TERM': 'linux', 02:59:45 INFO - 'TMOUT': '86400', 02:59:45 INFO - 'USER': 'cltbld', 02:59:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:45 INFO - '_': '/tools/buildbot/bin/python'} 02:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:45 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:47 INFO - warning: no files found matching '*.txt' 02:59:47 INFO - no previously-included directories found matching 'build' 02:59:47 INFO - no previously-included directories found matching 'dist' 02:59:47 INFO - no previously-included directories found matching '.git*' 02:59:47 INFO - Installing collected packages: jsonschema, functools32 02:59:48 INFO - Running setup.py install for functools32 02:59:48 INFO - warning: no files found matching '*.txt' 02:59:48 INFO - no previously-included directories found matching 'build' 02:59:48 INFO - no previously-included directories found matching 'dist' 02:59:48 INFO - no previously-included directories found matching '.git*' 02:59:48 INFO - Successfully installed jsonschema functools32 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:59:48 INFO - Using env: {'DISPLAY': ':0', 02:59:48 INFO - 'HOME': '/home/cltbld', 02:59:48 INFO - 'LANG': 'en_US.UTF-8', 02:59:48 INFO - 'LANGUAGE': 'en_US:en', 02:59:48 INFO - 'LOGNAME': 'cltbld', 02:59:48 INFO - 'MAIL': '/var/mail/cltbld', 02:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:48 INFO - 'MOZ_NO_REMOTE': '1', 02:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:48 INFO - 'NO_EM_RESTART': '1', 02:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:48 INFO - 'PWD': '/builds/slave/test', 02:59:48 INFO - 'SHELL': '/bin/bash', 02:59:48 INFO - 'SHLVL': '1', 02:59:48 INFO - 'TERM': 'linux', 02:59:48 INFO - 'TMOUT': '86400', 02:59:48 INFO - 'USER': 'cltbld', 02:59:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:48 INFO - '_': '/tools/buildbot/bin/python'} 02:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:48 INFO - Using env: {'DISPLAY': ':0', 02:59:48 INFO - 'HOME': '/home/cltbld', 02:59:48 INFO - 'LANG': 'en_US.UTF-8', 02:59:48 INFO - 'LANGUAGE': 'en_US:en', 02:59:48 INFO - 'LOGNAME': 'cltbld', 02:59:48 INFO - 'MAIL': '/var/mail/cltbld', 02:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:48 INFO - 'MOZ_NO_REMOTE': '1', 02:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:48 INFO - 'NO_EM_RESTART': '1', 02:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:48 INFO - 'PWD': '/builds/slave/test', 02:59:48 INFO - 'SHELL': '/bin/bash', 02:59:48 INFO - 'SHLVL': '1', 02:59:48 INFO - 'TERM': 'linux', 02:59:48 INFO - 'TMOUT': '86400', 02:59:48 INFO - 'USER': 'cltbld', 02:59:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:48 INFO - '_': '/tools/buildbot/bin/python'} 02:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:51 INFO - Downloading docopt-0.6.1.tar.gz 02:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:51 INFO - Running setup.py install for blobuploader 02:59:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:51 INFO - Running setup.py install for requests 02:59:51 INFO - Running setup.py install for docopt 02:59:51 INFO - Successfully installed blobuploader requests docopt 02:59:51 INFO - Cleaning up... 02:59:51 INFO - Return code: 0 02:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:51 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:51 INFO - Using env: {'DISPLAY': ':0', 02:59:51 INFO - 'HOME': '/home/cltbld', 02:59:51 INFO - 'LANG': 'en_US.UTF-8', 02:59:51 INFO - 'LANGUAGE': 'en_US:en', 02:59:51 INFO - 'LOGNAME': 'cltbld', 02:59:51 INFO - 'MAIL': '/var/mail/cltbld', 02:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:51 INFO - 'MOZ_NO_REMOTE': '1', 02:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:51 INFO - 'NO_EM_RESTART': '1', 02:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:51 INFO - 'PWD': '/builds/slave/test', 02:59:51 INFO - 'SHELL': '/bin/bash', 02:59:51 INFO - 'SHLVL': '1', 02:59:51 INFO - 'TERM': 'linux', 02:59:51 INFO - 'TMOUT': '86400', 02:59:51 INFO - 'USER': 'cltbld', 02:59:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:51 INFO - '_': '/tools/buildbot/bin/python'} 02:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:52 INFO - Running setup.py (path:/tmp/pip-ifqlA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:52 INFO - Running setup.py (path:/tmp/pip-_YB139-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:52 INFO - Running setup.py (path:/tmp/pip-tFual3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:52 INFO - Running setup.py (path:/tmp/pip-xmyZWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:52 INFO - Running setup.py (path:/tmp/pip-OcAjhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:52 INFO - Running setup.py (path:/tmp/pip-JT4Oc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:52 INFO - Running setup.py (path:/tmp/pip-ZHt00W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:52 INFO - Running setup.py (path:/tmp/pip-EHWhbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:52 INFO - Running setup.py (path:/tmp/pip-YdXpNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:52 INFO - Running setup.py (path:/tmp/pip-6c1yAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:52 INFO - Running setup.py (path:/tmp/pip-2rbBC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:52 INFO - Running setup.py (path:/tmp/pip-biDip3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:52 INFO - Running setup.py (path:/tmp/pip-c73jeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:53 INFO - Running setup.py (path:/tmp/pip-0JExcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:53 INFO - Running setup.py (path:/tmp/pip-sBLMS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:53 INFO - Running setup.py (path:/tmp/pip-5zGfAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:53 INFO - Running setup.py (path:/tmp/pip-V9RkC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:53 INFO - Running setup.py install for manifestparser 02:59:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozcrash 02:59:53 INFO - Running setup.py install for mozdebug 02:59:53 INFO - Running setup.py install for mozdevice 02:59:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozfile 02:59:53 INFO - Running setup.py install for mozhttpd 02:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozinfo 02:59:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozInstall 02:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozleak 02:59:54 INFO - Running setup.py install for mozlog 02:59:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for moznetwork 02:59:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozprocess 02:59:54 INFO - Running setup.py install for mozprofile 02:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozrunner 02:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozscreenshot 02:59:54 INFO - Running setup.py install for moztest 02:59:54 INFO - Running setup.py install for mozversion 02:59:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:55 INFO - Cleaning up... 02:59:55 INFO - Return code: 0 02:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:55 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:55 INFO - Using env: {'DISPLAY': ':0', 02:59:55 INFO - 'HOME': '/home/cltbld', 02:59:55 INFO - 'LANG': 'en_US.UTF-8', 02:59:55 INFO - 'LANGUAGE': 'en_US:en', 02:59:55 INFO - 'LOGNAME': 'cltbld', 02:59:55 INFO - 'MAIL': '/var/mail/cltbld', 02:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:55 INFO - 'MOZ_NO_REMOTE': '1', 02:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:55 INFO - 'NO_EM_RESTART': '1', 02:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:55 INFO - 'PWD': '/builds/slave/test', 02:59:55 INFO - 'SHELL': '/bin/bash', 02:59:55 INFO - 'SHLVL': '1', 02:59:55 INFO - 'TERM': 'linux', 02:59:55 INFO - 'TMOUT': '86400', 02:59:55 INFO - 'USER': 'cltbld', 02:59:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:55 INFO - '_': '/tools/buildbot/bin/python'} 02:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:55 INFO - Running setup.py (path:/tmp/pip-PIXfC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:55 INFO - Running setup.py (path:/tmp/pip-WZLBzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:55 INFO - Running setup.py (path:/tmp/pip-D83ZpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:55 INFO - Running setup.py (path:/tmp/pip-VNQlAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:55 INFO - Running setup.py (path:/tmp/pip-U5NLJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:55 INFO - Running setup.py (path:/tmp/pip-egNglc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:55 INFO - Running setup.py (path:/tmp/pip-J9XxkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:55 INFO - Running setup.py (path:/tmp/pip-p9ozrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:55 INFO - Running setup.py (path:/tmp/pip-CmRJVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:55 INFO - Running setup.py (path:/tmp/pip-ZZcjX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:56 INFO - Running setup.py (path:/tmp/pip-0bJB5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:56 INFO - Running setup.py (path:/tmp/pip-5LRBrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:56 INFO - Running setup.py (path:/tmp/pip-xR4pXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:56 INFO - Running setup.py (path:/tmp/pip-VbB2qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:56 INFO - Running setup.py (path:/tmp/pip-BJzFNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:56 INFO - Running setup.py (path:/tmp/pip-s3iNlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:56 INFO - Running setup.py (path:/tmp/pip-D8pmZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:58 INFO - Downloading blessings-1.6.tar.gz 02:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:58 INFO - Installing collected packages: blessings 02:59:58 INFO - Running setup.py install for blessings 02:59:58 INFO - Successfully installed blessings 02:59:58 INFO - Cleaning up... 02:59:58 INFO - Return code: 0 02:59:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:58 INFO - Reading from file tmpfile_stdout 02:59:58 INFO - Current package versions: 02:59:58 INFO - argparse == 1.2.1 02:59:58 INFO - blessings == 1.6 02:59:58 INFO - blobuploader == 1.2.4 02:59:58 INFO - docopt == 0.6.1 02:59:58 INFO - functools32 == 3.2.3-2 02:59:58 INFO - jsonschema == 2.5.1 02:59:58 INFO - manifestparser == 1.1 02:59:58 INFO - mozInstall == 1.12 02:59:58 INFO - mozcrash == 0.17 02:59:58 INFO - mozdebug == 0.1 02:59:58 INFO - mozdevice == 0.48 02:59:58 INFO - mozfile == 1.2 02:59:58 INFO - mozhttpd == 0.7 02:59:58 INFO - mozinfo == 0.9 02:59:58 INFO - mozleak == 0.1 02:59:58 INFO - mozlog == 3.3 02:59:58 INFO - moznetwork == 0.27 02:59:58 INFO - mozprocess == 0.23 02:59:58 INFO - mozprofile == 0.28 02:59:58 INFO - mozrunner == 6.12 02:59:58 INFO - mozscreenshot == 0.1 02:59:58 INFO - mozsystemmonitor == 0.3 02:59:58 INFO - moztest == 0.7 02:59:58 INFO - mozversion == 1.4 02:59:58 INFO - psutil == 3.1.1 02:59:58 INFO - requests == 1.2.3 02:59:58 INFO - wsgiref == 0.1.2 02:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:58 INFO - Using env: {'DISPLAY': ':0', 02:59:58 INFO - 'HOME': '/home/cltbld', 02:59:58 INFO - 'LANG': 'en_US.UTF-8', 02:59:58 INFO - 'LANGUAGE': 'en_US:en', 02:59:58 INFO - 'LOGNAME': 'cltbld', 02:59:58 INFO - 'MAIL': '/var/mail/cltbld', 02:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:58 INFO - 'MOZ_NO_REMOTE': '1', 02:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:58 INFO - 'NO_EM_RESTART': '1', 02:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:58 INFO - 'PWD': '/builds/slave/test', 02:59:58 INFO - 'SHELL': '/bin/bash', 02:59:58 INFO - 'SHLVL': '1', 02:59:58 INFO - 'TERM': 'linux', 02:59:58 INFO - 'TMOUT': '86400', 02:59:58 INFO - 'USER': 'cltbld', 02:59:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:58 INFO - '_': '/tools/buildbot/bin/python'} 02:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:59:59 INFO - Cleaning up... 02:59:59 INFO - Return code: 0 02:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:59 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 0x1160030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:59:59 INFO - Using env: {'DISPLAY': ':0', 02:59:59 INFO - 'HOME': '/home/cltbld', 02:59:59 INFO - 'LANG': 'en_US.UTF-8', 02:59:59 INFO - 'LANGUAGE': 'en_US:en', 02:59:59 INFO - 'LOGNAME': 'cltbld', 02:59:59 INFO - 'MAIL': '/var/mail/cltbld', 02:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:59 INFO - 'MOZ_NO_REMOTE': '1', 02:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:59 INFO - 'NO_EM_RESTART': '1', 02:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:59 INFO - 'PWD': '/builds/slave/test', 02:59:59 INFO - 'SHELL': '/bin/bash', 02:59:59 INFO - 'SHLVL': '1', 02:59:59 INFO - 'TERM': 'linux', 02:59:59 INFO - 'TMOUT': '86400', 02:59:59 INFO - 'USER': 'cltbld', 02:59:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 02:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:59 INFO - '_': '/tools/buildbot/bin/python'} 02:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:59 INFO - Cleaning up... 02:59:59 INFO - Return code: 0 02:59:59 INFO - Running post-action listener: _resource_record_post_action 02:59:59 INFO - Running post-action listener: _start_resource_monitoring 02:59:59 INFO - Starting resource monitoring. 02:59:59 INFO - [mozharness: 2016-08-07 09:59:59.376757Z] Finished create-virtualenv step (success) 02:59:59 INFO - [mozharness: 2016-08-07 09:59:59.377233Z] Running install step. 02:59:59 INFO - Running pre-action listener: _resource_record_pre_action 02:59:59 INFO - Running main action method: install 02:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:59 INFO - Reading from file tmpfile_stdout 02:59:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:59 INFO - Reading from file tmpfile_stdout 02:59:59 INFO - Output received: 02:59:59 INFO - Usage: mozinstall [options] installer 02:59:59 INFO - Options: 02:59:59 INFO - -h, --help show this help message and exit 02:59:59 INFO - -d DEST, --destination=DEST 02:59:59 INFO - Directory to install application into. [default: 02:59:59 INFO - "/builds/slave/test"] 02:59:59 INFO - --app=APP Application being installed. [default: firefox] 02:59:59 INFO - mkdir: /builds/slave/test/build/application 02:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:00:15 INFO - Reading from file tmpfile_stdout 03:00:15 INFO - Output received: 03:00:15 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:15 INFO - Running post-action listener: _resource_record_post_action 03:00:15 INFO - [mozharness: 2016-08-07 10:00:15.847823Z] Finished install step (success) 03:00:15 INFO - [mozharness: 2016-08-07 10:00:15.848072Z] Running run-tests step. 03:00:15 INFO - Running pre-action listener: _resource_record_pre_action 03:00:15 INFO - Running main action method: run_tests 03:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:15 INFO - Python 2.7.3 03:00:15 INFO - Return code: 0 03:00:15 INFO - grabbing minidump binary from tooltool 03:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:15 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 0x141f3b0>, '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 0x14202b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1420740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:15 INFO - Return code: 0 03:00:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 03:00:15 INFO - Using env: {'DISPLAY': ':0', 03:00:15 INFO - 'HOME': '/home/cltbld', 03:00:15 INFO - 'LANG': 'en_US.UTF-8', 03:00:15 INFO - 'LANGUAGE': 'en_US:en', 03:00:15 INFO - 'LOGNAME': 'cltbld', 03:00:15 INFO - 'MAIL': '/var/mail/cltbld', 03:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:15 INFO - 'MOZ_NO_REMOTE': '1', 03:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:15 INFO - 'NO_EM_RESTART': '1', 03:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:15 INFO - 'PWD': '/builds/slave/test', 03:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:15 INFO - 'SHELL': '/bin/bash', 03:00:15 INFO - 'SHLVL': '1', 03:00:15 INFO - 'TERM': 'linux', 03:00:15 INFO - 'TMOUT': '86400', 03:00:15 INFO - 'USER': 'cltbld', 03:00:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657', 03:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:15 INFO - '_': '/tools/buildbot/bin/python'} 03:00:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 03:00:16 INFO - mozversion application_buildid: 20160807001853 03:00:16 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:00:16 INFO - mozversion application_display_name: Nightly 03:00:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:16 INFO - mozversion application_name: Firefox 03:00:16 INFO - mozversion application_remotingname: firefox 03:00:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:00:16 INFO - mozversion application_vendor: Mozilla 03:00:16 INFO - mozversion application_version: 51.0a1 03:00:16 INFO - mozversion platform_buildid: 20160807001853 03:00:16 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:00:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:00:16 INFO - mozversion platform_version: 51.0a1 03:00:16 INFO - using testdate: 1470564016 03:00:16 INFO - actual date: 1470564016 03:00:16 INFO - starting webserver on 'localhost:37054' 03:00:16 INFO - SUITE-START | Running 2 tests 03:00:16 INFO - TEST-START | dromaeo_css 03:00:16 INFO - operating with platform_type : linux_ 03:00:16 INFO - Initialising browser for dromaeo_css test... 03:00:16 INFO - TEST-INFO | started process 10742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXn1kG/profile http://localhost:37054/getInfo.html) 03:00:20 INFO - PROCESS | 10742 | __metrics Screen width/height:1600/1200 03:00:20 INFO - PROCESS | 10742 | colorDepth:24 03:00:20 INFO - PROCESS | 10742 | Browser inner width/height: 1024/697 03:00:20 INFO - PROCESS | 10742 | __metrics 03:00:21 INFO - PROCESS | 10742 | 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" 03:00:21 INFO - PROCESS | 10742 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:22 INFO - TEST-INFO | 10742: exit 0 03:00:22 INFO - Browser initialized. 03:00:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:22 INFO - TEST-INFO | started process 10821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXn1kG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:34 INFO - PROCESS | 10821 | RSS: Main: 157954048 03:00:34 INFO - PROCESS | 10821 | 03:01:25 INFO - PROCESS | 10821 | 1470564085836 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] 03:03:37 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37054/tests/dromaeo/cssquery-ext.html) 03:03:39 INFO - PROCESS | 10821 | RSS: Main: 234610688 03:03:39 INFO - PROCESS | 10821 | 03:06:41 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-ext.html (next: http://localhost:37054/tests/dromaeo/cssquery-jquery.html) 03:06:42 INFO - PROCESS | 10821 | RSS: Main: 238755840 03:06:42 INFO - PROCESS | 10821 | 03:09:44 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37054/tests/dromaeo/cssquery-mootools.html) 03:09:45 INFO - PROCESS | 10821 | RSS: Main: 230019072 03:09:45 INFO - PROCESS | 10821 | 03:12:47 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37054/tests/dromaeo/cssquery-prototype.html) 03:12:47 INFO - PROCESS | 10821 | RSS: Main: 190427136 03:12:47 INFO - PROCESS | 10821 | 03:15:50 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37054/tests/dromaeo/cssquery-yui.html) 03:15:51 INFO - PROCESS | 10821 | RSS: Main: 191782912 03:15:51 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | Cycle 1(1): loaded http://localhost:37054/tests/dromaeo/cssquery-yui.html (next: http://localhost:37054/tests/dromaeo/cssquery-dojo.html) 03:18:54 INFO - PROCESS | 10821 | RSS: Main: 281739264 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | __start_tp_report 03:18:54 INFO - PROCESS | 10821 | _x_x_mozilla_page_load 03:18:54 INFO - PROCESS | 10821 | _x_x_mozilla_page_load_details 03:18:54 INFO - PROCESS | 10821 | |i|pagename|runs| 03:18:54 INFO - PROCESS | 10821 | |0;dojo.html;2627.9868600656996;2632.8420294782327;2646.8676566171684;2664.24069140295;2672.59911013348;4488.147252022113;4561.429821272341;4736.976315118424;4757.50046245144;4819.879503012422;4605.217113090775;4794.352762377078;4813.350197723306;4851.927221091686;4906;4340.631046361063;4360.106178233455;4412.294032954728;4450.109978004396;4456.064226512436;4341.674374421915;4477.2164871147415;4492.97753511232;4510.278355463127;4549.044700612859;4247.978760106211;4355.956440435587;4368.213721530124;4402.581754733311;4455.509893911667;4287.249731297011;4368.541303163154;4426.734395936254;4427.690061695683;4517.661175411825;4425.424694789656;4429.53489883564;4431.689781715281;4432.20220360335;4478.57453541913;4831.323614693945;4850.563449289546;4860;4868.610511159099;4873.853784386474;4900.58345040672;5109.259157422153;5164.070467315882;5191.454897235812;5237.685738855681;5241.947580524184;5285.814996475105;5294.41761406245;5295.920561191585;5297.549708274802;4912.7297998610065;4917.803287868481;4924.655274130848;4926.507349265116;4928.334674818925;4992.875178120504;5244.108501554745;5306.283651707047;5395.919061214085;5400.756965936543;5115.207142892783;5147.716875571805;5160.690358578498;5160.690358578498;5166.483351664879;5152.6650767699975;5157.535821775983;5191.506806853343;5191.896162076738;5201.973990130101;4821.397325334333;4963.404391473046;5041.42023667283;5131;5136.743162841843;5047.596192304607;5049.2426136079885;5086.92369614456;5092.236164575269;5098.209777484496;4317.546657600969;4331.913361732748;4343.131373725268;4348.391225228471;4389.978050109729;3684.244729830432;3688.8524459021337;3771.5662698789442;3796.4115562087923;3811.942820857689;4373.650107991417;4419.977900110479;4425.822967081281;4449.13241917823;4487.439070116236;5199.922001169985;5206.7917283309;5213.582913366921;5220.697190582422;5261.631685782035;4202.327627579572;4438.933415998763;4444.644428445717;4453.242948698729;4492.101579684077;4589.5639914208095;4634.443866736014;4644.303354496785;4658.767061646904;4720.858374248778;4877.585405240523;4880.829170978998;4882.853514394574;4885.120678277802;4931.506849315183;4861.149298872754;5179.171332586768;5188.922166167435;5192.324997750268;5244.108501554669;4770.475247722818;4839.128956787812;4839.975800120977;4847.127517046965;4908.85273441783;5088.389393272831;5094.541491265803;5098.923516147187;5099.082165210298;5151.201563757623;4880.292357608198;5157.432682405008;5167.431582525844;5172.508611681884;5172.637915345889;4774.355462012584;4820.204666230033;4821.108095002436;4856.125897338372;4868.90262194747;4844.515548445268;4847.95152048475;4854.029194161252;4858.90282194347;4901.387326584177;4691.390119284471;4792.3530323407285;4809;4838.491958344464;4843.2250839865455;5001.699898006132;5066.949330506795;5068.163752980717;5123.231515272739;5139.434662187082;4951.9257211142585;4967.677100988424;4972.801087956441;4974.651774375904;5014.749262536931 03:18:54 INFO - PROCESS | 10821 | |1;ext.html;570.5378643298927;578.4735890339791;578.537170263789;581.9214406055181;586.1237450012233;28849.711502884966;39295;40648.39027414584;40677.389839152434;45086.54913450865;41178.38232426508;41642.37536436956;41650.166996660046;41668.374974375336;41708.58291417085;7674.923250767504;7811.06267247931;7827.569483678395;7829.491083079582;7833.68665253392;7807.882881756778;7874.173211812763;7887.881681774749;7890;7894.881576776353;7838.490498117604;7867.095284042322;7903.525788452683;7942.285194332509;7948.960255198745;7848.568328741917;7890.723824666109;7891.881621775678;7898.684052637887;7906.960465197666;7816.960915195445;7857.371410287164;7870.29167374939;7884.290413862723;7885.487443316223;38816;39087.804560977296;39139;39174.80412597947;39297.60702392968;2992.880284788606;3095.1633087535215;3140.3876244132402;3187.3306605612847;3294.4399452093203;28576.571171441345;29409.411811763857;29465.11604651864;29482.262943426373;29545.556816647768;3522.225110475691;3667.1015601177614;3719.3119272934596;3787.5265591801026;3790.564085130218;249306;251093;251348;252349;252864.73567632228;53327;53652.19521707178;53696;53709;53720.731396342766;55589.722051390294;55623;55640.72179639076;55773.44226557682;55796;13350.599482015556;13509.459621615026;13561.118527295694;13562.389692463863;13568.796468052988;10395.220358473145;10462.895371046345;10465.529051192714;10469.424181669929;10499.580016799242;13631.591052268448;16095.356185752438;16440.917795411187;16451.177441127897;16513.504594862174;5355.651882627617;6270.968645156745;6380.936190638127;6549.770758023542;6587.868242635121;824.6948629007305;893.5442924108621;918.6830543462495;962.2686758063921;966.0966995858895;28046.2988425291;28564.285892852844;28688.282792929927;29218;29258.414831703674;975.0882924465648;976.9169620582188;994.6518718448485;1003.9609004680267;1022.5807418958192;14561.199134047518;15300.464483743015;15388;15499.561962408248;15538.689226215412;357722;358891;360849;360910;361519;49449.25826112611;49569.25646115311;49647.50352496501;49684.75157624261;49735.75132124316;1068.8129577323937;1135.8580177477816;1152.665726939195;1181.5569161564413;1232.3776492871043;26002.21993340203;28367.57448638231;28594.57108143338;29740.702592973794;30165.547516786828;42683.57316426796;43303.13393732045;43309;43310.91722706958;43403.34894976641;292795;294427;294858;294946;295335;24464.51070978606;25456.490870182122;25636;26894;36671.44992825163;42109;42354.78822605991;42750.14499709926;42758.57241427671;43369.78315108531;35839.283214335046;35945;36247.63752362548;36909.26181476409;36923;36513.43712861941;37017.25965480729;37043.25913481662;37604.623953760114;37909.241815164096;35940.46089308715;36471.27057458889;36491.817540912125;36521;37239.62760372362;31843.84078079595;33158.71639202082;33162;33942.66057339395;34026;25242.873785630953;25656.871715641304;25891.352716182246;25940.22179334623;25997.22839795423 03:18:54 INFO - PROCESS | 10821 | |2;jquery.html;334.9012041447776;363.709032773781;366.5033879093828;371.2630428599232;380.7924681048828;12895.677608059803;16107.43623973161;16545.999999999985;18016.819831801677;18142.546436339097;14558.854411455883;14740.705185896275;17755;17852.285908563674;17964.82035179648;4897.485763994782;4898.926516102261;5033.245013248005;5071.366079240095;5084.618653600976;3662.4323229899273;5000.524950129732;5076.974615126919;5080;5080.034793389263;5568.610197286192;5816.040353341694;5845.152452894327;5924.911126333109;5927.940720592782;5736;5902.203202567642;5920.289565252154;5949.732262048175;5983.132445795335;5236.240745091978;5243.86890327741;5245.396779370383;5247.86880327991;5248.239005344242;21128.577428451346;21129.154833806784;21311.254106106368;21503.462413439633;21731.67402488964;1974.3682021753045;2016.3648450737971;2017.8587498875086;2069.6585063464663;2524.798016158703;9126;9573.569189386424;9866.112049915542;12563.18339307942;13320.400581973834;1676.8658507319385;1713.9143042847809;1750.7023805953017;1777.7777777777778;1824.4253060285967;69221.30778692199;71455.28544714539;72540.63729681318;72861.63569182174;73776;8766.561671916379;9296.349255552183;9405.623775049058;9828.361156524803;10395.376277423378;12200.633980980585;12204.755904881853;12254.08094392924;12261.938690306491;12268.141230113806;6633.336666333328;6714.731410743516;6719.664016799141;6846.7945961621235;6859.588424694534;6346.365363463709;6465.224173099258;6494.123293355431;6497.15536980199;6505.7397704092255;3800.847966081326;3847.7498962567342;3874.8837534874;3964.0486283291802;3968.5634580196156;1805.3771448850125;1810.357323150289;1843.419322913278;1845.308009496439;1879.0792511669456;792.5284455748936;818.4311903227319;870.2907130688469;881.4446898454061;927.2628260532892;16458.09480478561;16994.830051699573;17139.571510712332;17458;18095.095245237684;828.668532586958;831.6257684042205;836.4061516323356;846.9110743371981;867.8177582707702;8374.665013399517;9977.201823854075;9978.201743860474;10020.462145031634;10046.246531510165;289984;294221;294499;387261;388497;48483;49129.50870491249;49256;58344;83388.58305708432;838.4927119092861;875.4484674655054;878.3368556739621;879.4591326334386;879.9868001979847;15661.530154095395;16009.199540023184;16619.41832035873;16642.251098700828;16872.24074916607;28289.292767680974;37657.24685506329;38888.41667374935;39925.60074399219;40457.59542404538;53721.46278537321;54536.651109392405;55413;56591.71704141453;57826.7108664454;7484.43866709988;7502.737404190827;7548.924510754822;7572.7728168155045;7684.538927664358;6445.548811583331;11678.6496405108;11700.35648039366;11803.82294265604;11885.643430697093;9594.808103838024;9894.20846332306;10032.598696052077;10460.424676642857;10502.474876256003;10079.848802268118;10144.847827282745;10235.692929212135;10398.22013349017;10484.423356715453;9928.900710992797;10149.64476243328;10245.129164021142;10287;10334.741631459274;7432.479726419315;7552.584607846621;7572.507786993828;7825.3739700824935;7876.6061696913775;8746.91253087461;9828.803423931624;10129.088382045651;10216.897831021595;10523.842142367717 03:18:54 INFO - PROCESS | 10821 | |3;mootools.html;1231.5566396097397;1318.4528420705408;1365.0376484578373;1397.6715471864115;1674.3888480704538;6127.540434467416;7413;7699.153093159748;7710.845783084342;7840.098388685303;7638.96180519098;7696.807579810507;7730.690772369113;7739.34215591674;7741.9225807741905;2073.5023594337326;2092.340912612522;2094.7381577302835;2097.255474306622;2101.95796084079;1978.0900785638623;1993.083181736403;1997.8601497895081;2109.7362829646295;2154.34292540775;2099.9265025724103;2105;2106.557622899193;2107.6838474228834;2123.140128248062;2088;2088.3839267416147;2089.6029754346628;2090.320645790109;2095.13052083386;1968.9507762305914;1987.8707883987638;2028.127905000849;2034.582910503358;2034.6744520876737;7584.355329796974;7590.6963721451075;7738.30355268023;7806.258405451473;7807.453478256524;4285.61429471349;4456.398386217851;4465.933011004838;4479.3281007848755;4480.148771733393;2699.8245114067718;2802;2846.558783388578;2858.1711303722104;2863.2698661841305;900.7162743735768;909.5861383070687;913.0732306708696;916.5142474488532;927.6243121535789;10321.329113607591;10443.11233545142;10451.84322235167;10463.947680261626;10466.372017678963;3707.0361705956648;3912.1002169500607;3992.1416895367056;3992.762243704461;4001.6998725095737;8180.181981801772;8181.631826567819;8181.672733090729;8182.631781569725;8188.2630563249595;4526.547345265513;4526.705764125387;4529.8641040768825;4530.07133537624;4536.455625324916;3308.40448719228;3886.106195575034;4049.4735684360844;4153.68847336451;4155.771432571177;3324.9168770780925;3338.7996720196866;3398.8130652814334;3432.8626854926024;3450.189205536697;997.491279447487;1013.7719013221966;1020.1175982774846;1022.9028242316969;1023.1405619279692;825.3685930263354;859.1151114352227;861.3625916821507;885.8361203177433;894.0255121917141;4959.305697202394;5010.799568017239;5077.8730531737;5160.406553246425;5361.624686272002;866.168478260864;928.9210417114621;939.1594522902101;950.458238803889;969.2149359019216;3553.307105114478;3727.9068023299633;3747.831347589365;3815.7901315427916;3881.670058045098;9272.397294175857;9621.27840411958;9635.421874687541;9639.759006024906;9640.75898102539;9607.423554586747;9608.991055939165;9610.038996100473;9614.230861531061;9618.951905240569;6853.109095817512;7148.428125749928;7150.856982860314;7182.317679820513;7314.451416143704;5426.0504411727;5568.721563921868;5580;5608.775648973995;5722.341930677859;8510.787230319043;8664.046954834837;8704.738857834274;8720.389572730102;8738.956305218433;8536.103709110703;8583.484990900566;8708.825823483368;8899.243564297107;8915.554222288989;5463.754131064191;6208.689565521796;6246.156768836331;6417.2299324081405;6441.420272175526;7255.165655949422;7585.62071896414;7627.847443051219;7637.541747495168;7641.235876412315;6586.571872828251;6636.104125942936;6687.297833727389;6772.796816095525;6891;6615.37153970372;6666.133402657623;6750.1562304711915;6754.831129221809;6789.388954994074;6198.2871969722255;6288.056791481315;6291.213598300213;6295.527835412271;6298.275698294571;4435.911281774411;4566.931496027496;4605.148047611203;4694.577488025958;4711.269753188261;4480.955190448054;4585.908281834411;4631.675782695179;4665.5567721066445;4858.3441235432765 03:18:54 INFO - PROCESS | 10821 | |4;prototype.html;290.51339007162994;296.161861930736;297.5046547498415;298.5775128193606;300.9563613276075;4665.300204969256;4782.795526996916;4856.830010949613;4865.805367785289;4872.561469467747;4676.929846052312;4732.976335118328;4745.311929770181;4764.475907650156;4812.759362031893;3768.566614839301;3769.227308401771;3770.905727356824;3781.432785082239;3797.9430308545393;3563.6436356364284;3796.9810150949206;3805.2009078093633;3840.0783811885085;3856.479375284343;3611.855525778966;3774.414965680324;3776.546814382278;3782.1490164712995;3787.905302367449;3747.882446417765;3765.7761227600863;3766.7551609145594;3772.622737726233;3773.584905660375;3332.750043746729;3335.34960682667;3340.131565792887;3343.331333733239;3346.6987971082717;4498.572635599646;4655.301704744282;4694.342792009122;4707.505711900236;4724.267738500538;4240.915181696349;4243.342281946303;4248.596383343577;4250.234957707611;4251.298535741599;5034.345535080416;5038.748062596856;5050.242463630448;5061.848144555633;5080.187170052811;3436.398630239698;3552.8401221945073;3562.3765840977985;3566.1262990567216;3602.189507360823;5188.896222075575;5199.298094757235;5206.687598744087;5217.217417387385;5218.66078704883;3600.963990360115;3607.260511595169;3626.9818650906577;3651.2332410193626;3660.249648821985;3515.402381595135;3682.410814269704;3684.613115622821;3688.0595448161084;3698.815059247027;4217.873463796091;4229.196452673982;4230.936535951963;4240.363945408213;4257.893552661209;5018.322526458881;5028.522290382408;5039.647224694236;5065.772040258197;5077.695338279715;1200.9219400738923;1242.1491278474275;1270.9364531773374;1285.794272916329;1290.2774446309909;833.9367306684027;851.2594043182471;856.8500512410303;858.7853036740814;861.0743450790426;4418.60232579063;4428.402165707588;4442.244818380883;4447.843560674248;4454.175977444183;5140.794368225229;5152.227165925141;5173.379194496684;5177.326947496801;5204.8959020819375;4298.376735373354;4373.671974601854;4380.342948557678;4405.224708433666;4430.335449682573;2402.49547595007;2426.8593760932335;2448.8285819992784;2453.877306134686;2454.104251948026;4310.771430142394;4322.675799315064;4347.891302717458;4349.847755328548;4374.313392589621;4494.280915053576;4546.272596384562;4631.305304204329;4661;4663.417072865892;4299.527052024275;4322.8703138905885;4323.416338794348;4332.328489084197;4344.827586206897;4563;4567.2920697291975;4577.382053422745;4587.807170135722;4602.2406302959635;4495.57292057254;4498.0104377037;4506.954930450785;4707.411573553306;5128.256402821645;4937.407511098691;4948.727819969792;4949.505049495022;4952.950470495393;4960.941209398059;3661.469086982426;3681.705463562962;3690.686291665131;3705.1478160023885;3707;5086.262491938722;5287.339082614673;5289.646107482134;5299.046171689133;5305.708186049805;5050.722210278323;5069.695818250917;5082.593392528663;5094.439611642791;5107.438181800073;5068.847934561969;5085.618578606545;5148.099082660594;5190.948090519047;5191.792328306977;4857.1742803724155;5005.524475174852;5067.569256613229;5070;5080.237964305384;5127.743612819269;5143.8456846294675;5156.922646160386;5161.09680805865;5164.638475306692;5019.924701129559;5031.572316353151;5050.898982020412;5060.898782024413;5069.214271787879 03:18:54 INFO - PROCESS | 10821 | |5;yui.html;622.2532960447464;626.8025571944837;665.5507532415618;710.2932582080828;724.1780579042786;13188.934055329722;14459.421623135087;14460.638484037905;14465.493707720232;14482;13928.373223204955;14051.086679365833;14070.296485175726;14075.718485630281;14088.154710717365;633.727497176214;643.3919945651361;759.9012128423325;768.1205020251822;783.1776634533717;772.7643068863994;782.8669126248523;783.2676447521557;783.3459061683473;783.6708582395407;825.162460102996;826.3802148388709;826.5454000299841;827.0819390476566;827.3711978896022;657.7369052379087;788.6884680551208;815.2825513548099;821.8808272800441;822.2969361196181;594.6699581732137;598.3896425645817;598.8083813179741;601.0053361686416;601.542827451136;12977.480900763958;13002.284874331908;13004.869951300556;13006.804897926539;13025.804612930719;12027.51889924402;12394.31831249281;12581.182223155558;12776.936115319457;13030.934845325713;10171.64399246023;10244.74388140295;10365.326253793479;10489.160867130611;10522.526486308134;4067.5118985721606;4126.216018956388;4135.813888375031;4163.292240319153;4281.293586558214;60854.695726521524;62461.37538624601;62634.68682656603;64352;65080.3491965079;9693.273004524688;9697.854532182022;9745.437892619977;9853.655122070693;9873.950630246803;19179.424617261506;19201.423957281302;19204.231830726894;19204.903975480313;19214.423567293004;6816.522843401013;6857.348551887562;6873.793786186422;6890.2076261229595;6894.172699276119;3640.7997560134445;3712.480252764615;3719.739618226698;3724.8510059597857;3727.8508859645854;2683.8926442942065;2784.5127102756937;2784.805063645566;2785.874635641401;2786;457.5173192282108;461.893764434182;466.2702870008426;471.00852705055365;471.2154263151882;417.7764895780743;482.95894848938235;489.5814078962507;495.78185598336614;496.5034965034965;7676.961615191888;7941.6029198539845;7999.680012799539;8115.79710507242;8396.244338009486;409.16368524046084;428.38954489851835;531.0573731626394;532.6963630730446;552.8811305569321;3560.092176494977;3658.9754868636824;3680.3743363627714;3762.2287431076566;3934.9803250984132;75035;106695;109508.4524577388;112545;113609.43195284136;92050;92684.53657731802;95887.52056239813;95998.52000739952;97654;83530.58234708788;83795.5810220945;84406;84463.15536844675;85122;6915.204751453446;7099.858002840017;7168.103987001625;7462.141853686679;7637.923620763943;47624.523754762005;48825.5117448821;49010.50989490059;49818;50124.74937625288;38653.613463865004;53985;54047.189292161434;55826.44173558213;58092;10539.262251642618;10835.783284334428;11107.111431085656;11213.215074944676;11438.71403214893;12814.615561533168;12866;12993.285369304778;13286.335683215993;13461.798073029107;12067.879321206676;12232.87767122353;12598.433070512032;12761.298128603015;12882.033847461666;10779.461026948778;11070.225084244348;11139.443027848412;11406.942965285121;11655;11675.532978680758;11777.234479758788;12608.117431779687;12615.684607884876;12622.11645184865;9184.12750788674;9361.812763744823;9410.670626528039;9719.951400243237;9931.702048938543;8572.314214862921;9230.815383692154;9639.500770722601;9694.321397502106;9839.212862970802 03:18:54 INFO - PROCESS | 10821 | __end_tp_report 03:18:54 INFO - PROCESS | 10821 | __start_cc_report 03:18:54 INFO - PROCESS | 10821 | _x_x_mozilla_cycle_collect,1129 03:18:54 INFO - PROCESS | 10821 | __end_cc_report 03:18:54 INFO - PROCESS | 10821 | __startTimestamp1470565134705__endTimestamp 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | ------- Summary: start ------- 03:18:54 INFO - PROCESS | 10821 | Number of tests: 6 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#0] dojo.html Cycles:165 Average:4742.60 Median:4856.13 stddev:512.48 (10.6%) stddev-sans-first:486.46 03:18:54 INFO - PROCESS | 10821 | Values: 2628.0 2632.8 2646.9 2664.2 2672.6 4488.1 4561.4 4737.0 4757.5 4819.9 4605.2 4794.4 4813.4 4851.9 4906.0 4340.6 4360.1 4412.3 4450.1 4456.1 4341.7 4477.2 4493.0 4510.3 4549.0 4248.0 4356.0 4368.2 4402.6 4455.5 4287.2 4368.5 4426.7 4427.7 4517.7 4425.4 4429.5 4431.7 4432.2 4478.6 4831.3 4850.6 4860.0 4868.6 4873.9 4900.6 5109.3 5164.1 5191.5 5237.7 5241.9 5285.8 5294.4 5295.9 5297.5 4912.7 4917.8 4924.7 4926.5 4928.3 4992.9 5244.1 5306.3 5395.9 5400.8 5115.2 5147.7 5160.7 5160.7 5166.5 5152.7 5157.5 5191.5 5191.9 5202.0 4821.4 4963.4 5041.4 5131.0 5136.7 5047.6 5049.2 5086.9 5092.2 5098.2 4317.5 4331.9 4343.1 4348.4 4390.0 3684.2 3688.9 3771.6 3796.4 3811.9 4373.7 4420.0 4425.8 4449.1 4487.4 5199.9 5206.8 5213.6 5220.7 5261.6 4202.3 4438.9 4444.6 4453.2 4492.1 4589.6 4634.4 4644.3 4658.8 4720.9 4877.6 4880.8 4882.9 4885.1 4931.5 4861.1 5179.2 5188.9 5192.3 5244.1 4770.5 4839.1 4840.0 4847.1 4908.9 5088.4 5094.5 5098.9 5099.1 5151.2 4880.3 5157.4 5167.4 5172.5 5172.6 4774.4 4820.2 4821.1 4856.1 4868.9 4844.5 4848.0 4854.0 4858.9 4901.4 4691.4 4792.4 4809.0 4838.5 4843.2 5001.7 5066.9 5068.2 5123.2 5139.4 4951.9 4967.7 4972.8 4974.7 5014.7 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#1] ext.html Cycles:180 Average:46245.67 Median:37030.26 stddev:80100.38 (216.3%) stddev-sans-first:80251.67 03:18:54 INFO - PROCESS | 10821 | Values: 570.5 578.5 578.5 581.9 586.1 28849.7 39295.0 40648.4 40677.4 45086.5 41178.4 41642.4 41650.2 41668.4 41708.6 7674.9 7811.1 7827.6 7829.5 7833.7 7807.9 7874.2 7887.9 7890.0 7894.9 7838.5 7867.1 7903.5 7942.3 7949.0 7848.6 7890.7 7891.9 7898.7 7907.0 7817.0 7857.4 7870.3 7884.3 7885.5 38816.0 39087.8 39139.0 39174.8 39297.6 2992.9 3095.2 3140.4 3187.3 3294.4 28576.6 29409.4 29465.1 29482.3 29545.6 3522.2 3667.1 3719.3 3787.5 3790.6 249306.0 251093.0 251348.0 252349.0 252864.7 53327.0 53652.2 53696.0 53709.0 53720.7 55589.7 55623.0 55640.7 55773.4 55796.0 13350.6 13509.5 13561.1 13562.4 13568.8 10395.2 10462.9 10465.5 10469.4 10499.6 13631.6 16095.4 16440.9 16451.2 16513.5 5355.7 6271.0 6380.9 6549.8 6587.9 824.7 893.5 918.7 962.3 966.1 28046.3 28564.3 28688.3 29218.0 29258.4 975.1 976.9 994.7 1004.0 1022.6 14561.2 15300.5 15388.0 15499.6 15538.7 357722.0 358891.0 360849.0 360910.0 361519.0 49449.3 49569.3 49647.5 49684.8 49735.8 1068.8 1135.9 1152.7 1181.6 1232.4 26002.2 28367.6 28594.6 29740.7 30165.5 42683.6 43303.1 43309.0 43310.9 43403.3 292795.0 294427.0 294858.0 294946.0 295335.0 24464.5 25456.5 25636.0 26894.0 36671.4 42109.0 42354.8 42750.1 42758.6 43369.8 35839.3 35945.0 36247.6 36909.3 36923.0 36513.4 37017.3 37043.3 37604.6 37909.2 35940.5 36471.3 36491.8 36521.0 37239.6 31843.8 33158.7 33162.0 33942.7 34026.0 25242.9 25656.9 25891.4 25940.2 25997.2 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#2] jquery.html Cycles:180 Average:22286.08 Median:26690.24 stddev:55402.90 (207.6%) stddev-sans-first:55533.80 03:18:54 INFO - PROCESS | 10821 | Values: 334.9 363.7 366.5 371.3 380.8 12895.7 16107.4 16546.0 18016.8 18142.5 14558.9 14740.7 17755.0 17852.3 17964.8 4897.5 4898.9 5033.2 5071.4 5084.6 3662.4 5000.5 5077.0 5080.0 5080.0 5568.6 5816.0 5845.2 5924.9 5927.9 5736.0 5902.2 5920.3 5949.7 5983.1 5236.2 5243.9 5245.4 5247.9 5248.2 21128.6 21129.2 21311.3 21503.5 21731.7 1974.4 2016.4 2017.9 2069.7 2524.8 9126.0 9573.6 9866.1 12563.2 13320.4 1676.9 1713.9 1750.7 1777.8 1824.4 69221.3 71455.3 72540.6 72861.6 73776.0 8766.6 9296.3 9405.6 9828.4 10395.4 12200.6 12204.8 12254.1 12261.9 12268.1 6633.3 6714.7 6719.7 6846.8 6859.6 6346.4 6465.2 6494.1 6497.2 6505.7 3800.8 3847.7 3874.9 3964.0 3968.6 1805.4 1810.4 1843.4 1845.3 1879.1 792.5 818.4 870.3 881.4 927.3 16458.1 16994.8 17139.6 17458.0 18095.1 828.7 831.6 836.4 846.9 867.8 8374.7 9977.2 9978.2 10020.5 10046.2 289984.0 294221.0 294499.0 387261.0 388497.0 48483.0 49129.5 49256.0 58344.0 83388.6 838.5 875.4 878.3 879.5 880.0 15661.5 16009.2 16619.4 16642.3 16872.2 28289.3 37657.2 38888.4 39925.6 40457.6 53721.5 54536.7 55413.0 56591.7 57826.7 7484.4 7502.7 7548.9 7572.8 7684.5 6445.5 11678.6 11700.4 11803.8 11885.6 9594.8 9894.2 10032.6 10460.4 10502.5 10079.8 10144.8 10235.7 10398.2 10484.4 9928.9 10149.6 10245.1 10287.0 10334.7 7432.5 7552.6 7572.5 7825.4 7876.6 8746.9 9828.8 10129.1 10216.9 10523.8 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#3] mootools.html Cycles:180 Average:5018.09 Median:5516.24 stddev:2819.70 (51.1%) stddev-sans-first:2813.25 03:18:54 INFO - PROCESS | 10821 | Values: 1231.6 1318.5 1365.0 1397.7 1674.4 6127.5 7413.0 7699.2 7710.8 7840.1 7639.0 7696.8 7730.7 7739.3 7741.9 2073.5 2092.3 2094.7 2097.3 2102.0 1978.1 1993.1 1997.9 2109.7 2154.3 2099.9 2105.0 2106.6 2107.7 2123.1 2088.0 2088.4 2089.6 2090.3 2095.1 1969.0 1987.9 2028.1 2034.6 2034.7 7584.4 7590.7 7738.3 7806.3 7807.5 4285.6 4456.4 4465.9 4479.3 4480.1 2699.8 2802.0 2846.6 2858.2 2863.3 900.7 909.6 913.1 916.5 927.6 10321.3 10443.1 10451.8 10463.9 10466.4 3707.0 3912.1 3992.1 3992.8 4001.7 8180.2 8181.6 8181.7 8182.6 8188.3 4526.5 4526.7 4529.9 4530.1 4536.5 3308.4 3886.1 4049.5 4153.7 4155.8 3324.9 3338.8 3398.8 3432.9 3450.2 997.5 1013.8 1020.1 1022.9 1023.1 825.4 859.1 861.4 885.8 894.0 4959.3 5010.8 5077.9 5160.4 5361.6 866.2 928.9 939.2 950.5 969.2 3553.3 3727.9 3747.8 3815.8 3881.7 9272.4 9621.3 9635.4 9639.8 9640.8 9607.4 9609.0 9610.0 9614.2 9619.0 6853.1 7148.4 7150.9 7182.3 7314.5 5426.1 5568.7 5580.0 5608.8 5722.3 8510.8 8664.0 8704.7 8720.4 8739.0 8536.1 8583.5 8708.8 8899.2 8915.6 5463.8 6208.7 6246.2 6417.2 6441.4 7255.2 7585.6 7627.8 7637.5 7641.2 6586.6 6636.1 6687.3 6772.8 6891.0 6615.4 6666.1 6750.2 6754.8 6789.4 6198.3 6288.1 6291.2 6295.5 6298.3 4435.9 4566.9 4605.1 4694.6 4711.3 4481.0 4585.9 4631.7 4665.6 4858.3 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#4] prototype.html Cycles:180 Average:4108.14 Median:4494.93 stddev:1197.94 (26.7%) stddev-sans-first:1166.53 03:18:54 INFO - PROCESS | 10821 | Values: 290.5 296.2 297.5 298.6 301.0 4665.3 4782.8 4856.8 4865.8 4872.6 4676.9 4733.0 4745.3 4764.5 4812.8 3768.6 3769.2 3770.9 3781.4 3797.9 3563.6 3797.0 3805.2 3840.1 3856.5 3611.9 3774.4 3776.5 3782.1 3787.9 3747.9 3765.8 3766.8 3772.6 3773.6 3332.8 3335.3 3340.1 3343.3 3346.7 4498.6 4655.3 4694.3 4707.5 4724.3 4240.9 4243.3 4248.6 4250.2 4251.3 5034.3 5038.7 5050.2 5061.8 5080.2 3436.4 3552.8 3562.4 3566.1 3602.2 5188.9 5199.3 5206.7 5217.2 5218.7 3601.0 3607.3 3627.0 3651.2 3660.2 3515.4 3682.4 3684.6 3688.1 3698.8 4217.9 4229.2 4230.9 4240.4 4257.9 5018.3 5028.5 5039.6 5065.8 5077.7 1200.9 1242.1 1270.9 1285.8 1290.3 833.9 851.3 856.9 858.8 861.1 4418.6 4428.4 4442.2 4447.8 4454.2 5140.8 5152.2 5173.4 5177.3 5204.9 4298.4 4373.7 4380.3 4405.2 4430.3 2402.5 2426.9 2448.8 2453.9 2454.1 4310.8 4322.7 4347.9 4349.8 4374.3 4494.3 4546.3 4631.3 4661.0 4663.4 4299.5 4322.9 4323.4 4332.3 4344.8 4563.0 4567.3 4577.4 4587.8 4602.2 4495.6 4498.0 4507.0 4707.4 5128.3 4937.4 4948.7 4949.5 4953.0 4960.9 3661.5 3681.7 3690.7 3705.1 3707.0 5086.3 5287.3 5289.6 5299.0 5305.7 5050.7 5069.7 5082.6 5094.4 5107.4 5068.8 5085.6 5148.1 5190.9 5191.8 4857.2 5005.5 5067.6 5070.0 5080.2 5127.7 5143.8 5156.9 5161.1 5164.6 5019.9 5031.6 5050.9 5060.9 5069.2 03:18:54 INFO - PROCESS | 10821 | 03:18:54 INFO - PROCESS | 10821 | [#5] yui.html Cycles:180 Average:18370.42 Median:24657.55 stddev:27180.34 (110.2%) stddev-sans-first:27223.92 03:18:54 INFO - PROCESS | 10821 | Values: 622.3 626.8 665.6 710.3 724.2 13188.9 14459.4 14460.6 14465.5 14482.0 13928.4 14051.1 14070.3 14075.7 14088.2 633.7 643.4 759.9 768.1 783.2 772.8 782.9 783.3 783.3 783.7 825.2 826.4 826.5 827.1 827.4 657.7 788.7 815.3 821.9 822.3 594.7 598.4 598.8 601.0 601.5 12977.5 13002.3 13004.9 13006.8 13025.8 12027.5 12394.3 12581.2 12776.9 13030.9 10171.6 10244.7 10365.3 10489.2 10522.5 4067.5 4126.2 4135.8 4163.3 4281.3 60854.7 62461.4 62634.7 64352.0 65080.3 9693.3 9697.9 9745.4 9853.7 9874.0 19179.4 19201.4 19204.2 19204.9 19214.4 6816.5 6857.3 6873.8 6890.2 6894.2 3640.8 3712.5 3719.7 3724.9 3727.9 2683.9 2784.5 2784.8 2785.9 2786.0 457.5 461.9 466.3 471.0 471.2 417.8 483.0 489.6 495.8 496.5 7677.0 7941.6 7999.7 8115.8 8396.2 409.2 428.4 531.1 532.7 552.9 3560.1 3659.0 3680.4 3762.2 3935.0 75035.0 106695.0 109508.5 112545.0 113609.4 92050.0 92684.5 95887.5 95998.5 97654.0 83530.6 83795.6 84406.0 84463.2 85122.0 6915.2 7099.9 7168.1 7462.1 7637.9 47624.5 48825.5 49010.5 49818.0 50124.7 38653.6 53985.0 54047.2 55826.4 58092.0 10539.3 10835.8 11107.1 11213.2 11438.7 12814.6 12866.0 12993.3 13286.3 13461.8 12067.9 12232.9 12598.4 12761.3 12882.0 10779.5 11070.2 11139.4 11406.9 11655.0 11675.5 11777.2 12608.1 12615.7 12622.1 9184.1 9361.8 9410.7 9720.0 9931.7 8572.3 9230.8 9639.5 9694.3 9839.2 03:18:54 INFO - PROCESS | 10821 | -------- Summary: end -------- 03:18:54 INFO - PROCESS | 10821 | 03:18:55 INFO - TEST-INFO | 10821: exit 0 03:18:55 INFO - TEST-OK | dromaeo_css | took 1119437ms 03:18:55 INFO - TEST-START | kraken 03:18:55 INFO - operating with platform_type : linux_ 03:18:55 INFO - Initialising browser for kraken test... 03:18:55 INFO - TEST-INFO | started process 11014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqgL84/profile http://localhost:37054/getInfo.html) 03:18:59 INFO - PROCESS | 11014 | __metrics Screen width/height:1600/1200 03:18:59 INFO - PROCESS | 11014 | colorDepth:24 03:18:59 INFO - PROCESS | 11014 | Browser inner width/height: 1024/697 03:18:59 INFO - PROCESS | 11014 | __metrics 03:19:00 INFO - PROCESS | 11014 | 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" 03:19:00 INFO - PROCESS | 11014 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:01 INFO - TEST-INFO | 11014: exit 0 03:19:01 INFO - Browser initialized. 03:19:01 INFO - Running cycle 1/1 for kraken test... 03:19:01 INFO - TEST-INFO | started process 11092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqgL84/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:13 INFO - PROCESS | 11092 | RSS: Main: 157876224 03:19:13 INFO - PROCESS | 11092 | 03:19:15 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:16 INFO - PROCESS | 11092 | RSS: Main: 213585920 03:19:16 INFO - PROCESS | 11092 | 03:19:19 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-dft) 03:19:20 INFO - PROCESS | 11092 | RSS: Main: 191885312 03:19:20 INFO - PROCESS | 11092 | 03:19:23 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-fft) 03:19:24 INFO - PROCESS | 11092 | RSS: Main: 273354752 03:19:24 INFO - PROCESS | 11092 | 03:19:26 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37054/tests/kraken/driver.html?testName=audio-oscillator) 03:19:26 INFO - PROCESS | 11092 | RSS: Main: 181297152 03:19:26 INFO - PROCESS | 11092 | 03:19:29 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:29 INFO - PROCESS | 11092 | RSS: Main: 185155584 03:19:29 INFO - PROCESS | 11092 | 03:19:32 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:33 INFO - PROCESS | 11092 | RSS: Main: 221827072 03:19:33 INFO - PROCESS | 11092 | 03:19:36 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37054/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:37 INFO - PROCESS | 11092 | RSS: Main: 214994944 03:19:37 INFO - PROCESS | 11092 | 03:19:40 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37054/tests/kraken/driver.html?testName=json-parse-financial) 03:19:41 INFO - PROCESS | 11092 | RSS: Main: 218574848 03:19:41 INFO - PROCESS | 11092 | 03:19:42 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:43 INFO - PROCESS | 11092 | RSS: Main: 184344576 03:19:43 INFO - PROCESS | 11092 | 03:19:45 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:45 INFO - PROCESS | 11092 | RSS: Main: 190726144 03:19:45 INFO - PROCESS | 11092 | 03:19:47 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:48 INFO - PROCESS | 11092 | RSS: Main: 194949120 03:19:48 INFO - PROCESS | 11092 | 03:19:51 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:52 INFO - PROCESS | 11092 | RSS: Main: 188768256 03:19:52 INFO - PROCESS | 11092 | 03:19:54 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:55 INFO - PROCESS | 11092 | RSS: Main: 192294912 03:19:55 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:37054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37054/tests/kraken/driver.html?testName=ai-astar) 03:19:57 INFO - PROCESS | 11092 | RSS: Main: 243195904 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | __start_tp_report 03:19:57 INFO - PROCESS | 11092 | _x_x_mozilla_page_load 03:19:57 INFO - PROCESS | 11092 | _x_x_mozilla_page_load_details 03:19:57 INFO - PROCESS | 11092 | |i|pagename|runs| 03:19:57 INFO - PROCESS | 11092 | |0;ai-astar;104;114;114;114;114;113;114;113;112;114 03:19:57 INFO - PROCESS | 11092 | |1;audio-beat-detection;144;126;129;184;121;123;148;120;157;124 03:19:57 INFO - PROCESS | 11092 | |2;audio-dft;164;160;159;162;160;160;161;161;162;160 03:19:57 INFO - PROCESS | 11092 | |3;audio-fft;76;76;75;109;75;77;74;75;120;76 03:19:57 INFO - PROCESS | 11092 | |4;audio-oscillator;84;85;133;84;84;85;129;85;84;132 03:19:57 INFO - PROCESS | 11092 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;118;117;116 03:19:57 INFO - PROCESS | 11092 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;146 03:19:57 INFO - PROCESS | 11092 | |7;imaging-desaturate;96;94;95;96;95;95;95;96;95;95 03:19:57 INFO - PROCESS | 11092 | |8;json-parse-financial;64;62;63;63;62;64;62;62;63;70 03:19:57 INFO - PROCESS | 11092 | |9;json-stringify-tinderbox;65;65;65;66;66;65;65;65;66;65 03:19:57 INFO - PROCESS | 11092 | |10;stanford-crypto-aes;82;79;79;80;79;78;78;78;79;80 03:19:57 INFO - PROCESS | 11092 | |11;stanford-crypto-ccm;128;138;131;127;129;130;128;130;154;131 03:19:57 INFO - PROCESS | 11092 | |12;stanford-crypto-pbkdf2;167;165;167;167;166;171;165;165;165;164 03:19:57 INFO - PROCESS | 11092 | |13;stanford-crypto-sha256-iterative;67;68;70;66;67;68;66;65;65;68 03:19:57 INFO - PROCESS | 11092 | __end_tp_report 03:19:57 INFO - PROCESS | 11092 | __start_cc_report 03:19:57 INFO - PROCESS | 11092 | _x_x_mozilla_cycle_collect,1917 03:19:57 INFO - PROCESS | 11092 | __end_cc_report 03:19:57 INFO - PROCESS | 11092 | __startTimestamp1470565197506__endTimestamp 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | ------- Summary: start ------- 03:19:57 INFO - PROCESS | 11092 | Number of tests: 14 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.10 (2.7%) stddev-sans-first:0.73 03:19:57 INFO - PROCESS | 11092 | Values: 104.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 112.0 114.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:136.50 stddev:20.74 (15.2%) stddev-sans-first:21.87 03:19:57 INFO - PROCESS | 11092 | Values: 144.0 126.0 129.0 184.0 121.0 123.0 148.0 120.0 157.0 124.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.01 03:19:57 INFO - PROCESS | 11092 | Values: 164.0 160.0 159.0 162.0 160.0 160.0 161.0 161.0 162.0 160.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:16.67 (22.1%) stddev-sans-first:17.47 03:19:57 INFO - PROCESS | 11092 | Values: 76.0 76.0 75.0 109.0 75.0 77.0 74.0 75.0 120.0 76.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:84.00 stddev:22.68 (27.0%) stddev-sans-first:23.44 03:19:57 INFO - PROCESS | 11092 | Values: 84.0 85.0 133.0 84.0 84.0 85.0 129.0 85.0 84.0 132.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:19:57 INFO - PROCESS | 11092 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 116.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 03:19:57 INFO - PROCESS | 11092 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 03:19:57 INFO - PROCESS | 11092 | Values: 96.0 94.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:2.42 (3.8%) stddev-sans-first:2.55 03:19:57 INFO - PROCESS | 11092 | Values: 64.0 62.0 63.0 63.0 62.0 64.0 62.0 62.0 63.0 70.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:19:57 INFO - PROCESS | 11092 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 65.0 65.0 66.0 65.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:1.23 (1.6%) stddev-sans-first:0.78 03:19:57 INFO - PROCESS | 11092 | Values: 82.0 79.0 79.0 80.0 79.0 78.0 78.0 78.0 79.0 80.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.50 stddev:8.11 (6.2%) stddev-sans-first:8.43 03:19:57 INFO - PROCESS | 11092 | Values: 128.0 138.0 131.0 127.0 129.0 130.0 128.0 130.0 154.0 131.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:1.99 (1.2%) stddev-sans-first:2.09 03:19:57 INFO - PROCESS | 11092 | Values: 167.0 165.0 167.0 167.0 166.0 171.0 165.0 165.0 165.0 164.0 03:19:57 INFO - PROCESS | 11092 | 03:19:57 INFO - PROCESS | 11092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.56 (2.3%) stddev-sans-first:1.66 03:19:57 INFO - PROCESS | 11092 | Values: 67.0 68.0 70.0 66.0 67.0 68.0 66.0 65.0 65.0 68.0 03:19:57 INFO - PROCESS | 11092 | -------- Summary: end -------- 03:19:57 INFO - PROCESS | 11092 | 03:19:58 INFO - TEST-INFO | 11092: exit 0 03:19:58 INFO - TEST-OK | kraken | took 63057ms 03:19:58 INFO - SUITE-END | took 1182s 03:19:58 INFO - Completed test suite (00:19:42) 03:19:58 INFO - javascript benchmark 03:19:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.9868600656996, 2632.8420294782327, 2646.8676566171684, 2664.24069140295, 2672.59911013348, 4488.147252022113, 4561.429821272341, 4736.976315118424, 4757.50046245144, 4819.879503012422, 4605.217113090775, 4794.352762377078, 4813.350197723306, 4851.927221091686, 4906.0, 4340.631046361063, 4360.106178233455, 4412.294032954728, 4450.109978004396, 4456.064226512436, 4341.674374421915, 4477.2164871147415, 4492.97753511232, 4510.278355463127, 4549.044700612859, 4247.978760106211, 4355.956440435587, 4368.213721530124, 4402.581754733311, 4455.509893911667, 4287.249731297011, 4368.541303163154, 4426.734395936254, 4427.690061695683, 4517.661175411825, 4425.424694789656, 4429.53489883564, 4431.689781715281, 4432.20220360335, 4478.57453541913, 4831.323614693945, 4850.563449289546, 4860.0, 4868.610511159099, 4873.853784386474, 4900.58345040672, 5109.259157422153, 5164.070467315882, 5191.454897235812, 5237.685738855681, 5241.947580524184, 5285.814996475105, 5294.41761406245, 5295.920561191585, 5297.549708274802, 4912.7297998610065, 4917.803287868481, 4924.655274130848, 4926.507349265116, 4928.334674818925, 4992.875178120504, 5244.108501554745, 5306.283651707047, 5395.919061214085, 5400.756965936543, 5115.207142892783, 5147.716875571805, 5160.690358578498, 5160.690358578498, 5166.483351664879, 5152.6650767699975, 5157.535821775983, 5191.506806853343, 5191.896162076738, 5201.973990130101, 4821.397325334333, 4963.404391473046, 5041.42023667283, 5131.0, 5136.743162841843, 5047.596192304607, 5049.2426136079885, 5086.92369614456, 5092.236164575269, 5098.209777484496, 4317.546657600969, 4331.913361732748, 4343.131373725268, 4348.391225228471, 4389.978050109729, 3684.244729830432, 3688.8524459021337, 3771.5662698789442, 3796.4115562087923, 3811.942820857689, 4373.650107991417, 4419.977900110479, 4425.822967081281, 4449.13241917823, 4487.439070116236, 5199.922001169985, 5206.7917283309, 5213.582913366921, 5220.697190582422, 5261.631685782035, 4202.327627579572, 4438.933415998763, 4444.644428445717, 4453.242948698729, 4492.101579684077, 4589.5639914208095, 4634.443866736014, 4644.303354496785, 4658.767061646904, 4720.858374248778, 4877.585405240523, 4880.829170978998, 4882.853514394574, 4885.120678277802, 4931.506849315183, 4861.149298872754, 5179.171332586768, 5188.922166167435, 5192.324997750268, 5244.108501554669, 4770.475247722818, 4839.128956787812, 4839.975800120977, 4847.127517046965, 4908.85273441783, 5088.389393272831, 5094.541491265803, 5098.923516147187, 5099.082165210298, 5151.201563757623, 4880.292357608198, 5157.432682405008, 5167.431582525844, 5172.508611681884, 5172.637915345889, 4774.355462012584, 4820.204666230033, 4821.108095002436, 4856.125897338372, 4868.90262194747, 4844.515548445268, 4847.95152048475, 4854.029194161252, 4858.90282194347, 4901.387326584177, 4691.390119284471, 4792.3530323407285, 4809.0, 4838.491958344464, 4843.2250839865455, 5001.699898006132, 5066.949330506795, 5068.163752980717, 5123.231515272739, 5139.434662187082, 4951.9257211142585, 4967.677100988424, 4972.801087956441, 4974.651774375904, 5014.749262536931], "value": 4709.163830680493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5378643298927, 578.4735890339791, 578.537170263789, 581.9214406055181, 586.1237450012233, 28849.711502884966, 39295.0, 40648.39027414584, 40677.389839152434, 45086.54913450865, 41178.38232426508, 41642.37536436956, 41650.166996660046, 41668.374974375336, 41708.58291417085, 7674.923250767504, 7811.06267247931, 7827.569483678395, 7829.491083079582, 7833.68665253392, 7807.882881756778, 7874.173211812763, 7887.881681774749, 7890.0, 7894.881576776353, 7838.490498117604, 7867.095284042322, 7903.525788452683, 7942.285194332509, 7948.960255198745, 7848.568328741917, 7890.723824666109, 7891.881621775678, 7898.684052637887, 7906.960465197666, 7816.960915195445, 7857.371410287164, 7870.29167374939, 7884.290413862723, 7885.487443316223, 38816.0, 39087.804560977296, 39139.0, 39174.80412597947, 39297.60702392968, 2992.880284788606, 3095.1633087535215, 3140.3876244132402, 3187.3306605612847, 3294.4399452093203, 28576.571171441345, 29409.411811763857, 29465.11604651864, 29482.262943426373, 29545.556816647768, 3522.225110475691, 3667.1015601177614, 3719.3119272934596, 3787.5265591801026, 3790.564085130218, 249306.0, 251093.0, 251348.0, 252349.0, 252864.73567632228, 53327.0, 53652.19521707178, 53696.0, 53709.0, 53720.731396342766, 55589.722051390294, 55623.0, 55640.72179639076, 55773.44226557682, 55796.0, 13350.599482015556, 13509.459621615026, 13561.118527295694, 13562.389692463863, 13568.796468052988, 10395.220358473145, 10462.895371046345, 10465.529051192714, 10469.424181669929, 10499.580016799242, 13631.591052268448, 16095.356185752438, 16440.917795411187, 16451.177441127897, 16513.504594862174, 5355.651882627617, 6270.968645156745, 6380.936190638127, 6549.770758023542, 6587.868242635121, 824.6948629007305, 893.5442924108621, 918.6830543462495, 962.2686758063921, 966.0966995858895, 28046.2988425291, 28564.285892852844, 28688.282792929927, 29218.0, 29258.414831703674, 975.0882924465648, 976.9169620582188, 994.6518718448485, 1003.9609004680267, 1022.5807418958192, 14561.199134047518, 15300.464483743015, 15388.0, 15499.561962408248, 15538.689226215412, 357722.0, 358891.0, 360849.0, 360910.0, 361519.0, 49449.25826112611, 49569.25646115311, 49647.50352496501, 49684.75157624261, 49735.75132124316, 1068.8129577323937, 1135.8580177477816, 1152.665726939195, 1181.5569161564413, 1232.3776492871043, 26002.21993340203, 28367.57448638231, 28594.57108143338, 29740.702592973794, 30165.547516786828, 42683.57316426796, 43303.13393732045, 43309.0, 43310.91722706958, 43403.34894976641, 292795.0, 294427.0, 294858.0, 294946.0, 295335.0, 24464.51070978606, 25456.490870182122, 25636.0, 26894.0, 36671.44992825163, 42109.0, 42354.78822605991, 42750.14499709926, 42758.57241427671, 43369.78315108531, 35839.283214335046, 35945.0, 36247.63752362548, 36909.26181476409, 36923.0, 36513.43712861941, 37017.25965480729, 37043.25913481662, 37604.623953760114, 37909.241815164096, 35940.46089308715, 36471.27057458889, 36491.817540912125, 36521.0, 37239.62760372362, 31843.84078079595, 33158.71639202082, 33162.0, 33942.66057339395, 34026.0, 25242.873785630953, 25656.871715641304, 25891.352716182246, 25940.22179334623, 25997.22839795423], "value": 17524.483837566084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9012041447776, 363.709032773781, 366.5033879093828, 371.2630428599232, 380.7924681048828, 12895.677608059803, 16107.43623973161, 16545.999999999985, 18016.819831801677, 18142.546436339097, 14558.854411455883, 14740.705185896275, 17755.0, 17852.285908563674, 17964.82035179648, 4897.485763994782, 4898.926516102261, 5033.245013248005, 5071.366079240095, 5084.618653600976, 3662.4323229899273, 5000.524950129732, 5076.974615126919, 5080.0, 5080.034793389263, 5568.610197286192, 5816.040353341694, 5845.152452894327, 5924.911126333109, 5927.940720592782, 5736.0, 5902.203202567642, 5920.289565252154, 5949.732262048175, 5983.132445795335, 5236.240745091978, 5243.86890327741, 5245.396779370383, 5247.86880327991, 5248.239005344242, 21128.577428451346, 21129.154833806784, 21311.254106106368, 21503.462413439633, 21731.67402488964, 1974.3682021753045, 2016.3648450737971, 2017.8587498875086, 2069.6585063464663, 2524.798016158703, 9126.0, 9573.569189386424, 9866.112049915542, 12563.18339307942, 13320.400581973834, 1676.8658507319385, 1713.9143042847809, 1750.7023805953017, 1777.7777777777778, 1824.4253060285967, 69221.30778692199, 71455.28544714539, 72540.63729681318, 72861.63569182174, 73776.0, 8766.561671916379, 9296.349255552183, 9405.623775049058, 9828.361156524803, 10395.376277423378, 12200.633980980585, 12204.755904881853, 12254.08094392924, 12261.938690306491, 12268.141230113806, 6633.336666333328, 6714.731410743516, 6719.664016799141, 6846.7945961621235, 6859.588424694534, 6346.365363463709, 6465.224173099258, 6494.123293355431, 6497.15536980199, 6505.7397704092255, 3800.847966081326, 3847.7498962567342, 3874.8837534874, 3964.0486283291802, 3968.5634580196156, 1805.3771448850125, 1810.357323150289, 1843.419322913278, 1845.308009496439, 1879.0792511669456, 792.5284455748936, 818.4311903227319, 870.2907130688469, 881.4446898454061, 927.2628260532892, 16458.09480478561, 16994.830051699573, 17139.571510712332, 17458.0, 18095.095245237684, 828.668532586958, 831.6257684042205, 836.4061516323356, 846.9110743371981, 867.8177582707702, 8374.665013399517, 9977.201823854075, 9978.201743860474, 10020.462145031634, 10046.246531510165, 289984.0, 294221.0, 294499.0, 387261.0, 388497.0, 48483.0, 49129.50870491249, 49256.0, 58344.0, 83388.58305708432, 838.4927119092861, 875.4484674655054, 878.3368556739621, 879.4591326334386, 879.9868001979847, 15661.530154095395, 16009.199540023184, 16619.41832035873, 16642.251098700828, 16872.24074916607, 28289.292767680974, 37657.24685506329, 38888.41667374935, 39925.60074399219, 40457.59542404538, 53721.46278537321, 54536.651109392405, 55413.0, 56591.71704141453, 57826.7108664454, 7484.43866709988, 7502.737404190827, 7548.924510754822, 7572.7728168155045, 7684.538927664358, 6445.548811583331, 11678.6496405108, 11700.35648039366, 11803.82294265604, 11885.643430697093, 9594.808103838024, 9894.20846332306, 10032.598696052077, 10460.424676642857, 10502.474876256003, 10079.848802268118, 10144.847827282745, 10235.692929212135, 10398.22013349017, 10484.423356715453, 9928.900710992797, 10149.64476243328, 10245.129164021142, 10287.0, 10334.741631459274, 7432.479726419315, 7552.584607846621, 7572.507786993828, 7825.3739700824935, 7876.6061696913775, 8746.91253087461, 9828.803423931624, 10129.088382045651, 10216.897831021595, 10523.842142367717], "value": 8057.703569425201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.5566396097397, 1318.4528420705408, 1365.0376484578373, 1397.6715471864115, 1674.3888480704538, 6127.540434467416, 7413.0, 7699.153093159748, 7710.845783084342, 7840.098388685303, 7638.96180519098, 7696.807579810507, 7730.690772369113, 7739.34215591674, 7741.9225807741905, 2073.5023594337326, 2092.340912612522, 2094.7381577302835, 2097.255474306622, 2101.95796084079, 1978.0900785638623, 1993.083181736403, 1997.8601497895081, 2109.7362829646295, 2154.34292540775, 2099.9265025724103, 2105.0, 2106.557622899193, 2107.6838474228834, 2123.140128248062, 2088.0, 2088.3839267416147, 2089.6029754346628, 2090.320645790109, 2095.13052083386, 1968.9507762305914, 1987.8707883987638, 2028.127905000849, 2034.582910503358, 2034.6744520876737, 7584.355329796974, 7590.6963721451075, 7738.30355268023, 7806.258405451473, 7807.453478256524, 4285.61429471349, 4456.398386217851, 4465.933011004838, 4479.3281007848755, 4480.148771733393, 2699.8245114067718, 2802.0, 2846.558783388578, 2858.1711303722104, 2863.2698661841305, 900.7162743735768, 909.5861383070687, 913.0732306708696, 916.5142474488532, 927.6243121535789, 10321.329113607591, 10443.11233545142, 10451.84322235167, 10463.947680261626, 10466.372017678963, 3707.0361705956648, 3912.1002169500607, 3992.1416895367056, 3992.762243704461, 4001.6998725095737, 8180.181981801772, 8181.631826567819, 8181.672733090729, 8182.631781569725, 8188.2630563249595, 4526.547345265513, 4526.705764125387, 4529.8641040768825, 4530.07133537624, 4536.455625324916, 3308.40448719228, 3886.106195575034, 4049.4735684360844, 4153.68847336451, 4155.771432571177, 3324.9168770780925, 3338.7996720196866, 3398.8130652814334, 3432.8626854926024, 3450.189205536697, 997.491279447487, 1013.7719013221966, 1020.1175982774846, 1022.9028242316969, 1023.1405619279692, 825.3685930263354, 859.1151114352227, 861.3625916821507, 885.8361203177433, 894.0255121917141, 4959.305697202394, 5010.799568017239, 5077.8730531737, 5160.406553246425, 5361.624686272002, 866.168478260864, 928.9210417114621, 939.1594522902101, 950.458238803889, 969.2149359019216, 3553.307105114478, 3727.9068023299633, 3747.831347589365, 3815.7901315427916, 3881.670058045098, 9272.397294175857, 9621.27840411958, 9635.421874687541, 9639.759006024906, 9640.75898102539, 9607.423554586747, 9608.991055939165, 9610.038996100473, 9614.230861531061, 9618.951905240569, 6853.109095817512, 7148.428125749928, 7150.856982860314, 7182.317679820513, 7314.451416143704, 5426.0504411727, 5568.721563921868, 5580.0, 5608.775648973995, 5722.341930677859, 8510.787230319043, 8664.046954834837, 8704.738857834274, 8720.389572730102, 8738.956305218433, 8536.103709110703, 8583.484990900566, 8708.825823483368, 8899.243564297107, 8915.554222288989, 5463.754131064191, 6208.689565521796, 6246.156768836331, 6417.2299324081405, 6441.420272175526, 7255.165655949422, 7585.62071896414, 7627.847443051219, 7637.541747495168, 7641.235876412315, 6586.571872828251, 6636.104125942936, 6687.297833727389, 6772.796816095525, 6891.0, 6615.37153970372, 6666.133402657623, 6750.1562304711915, 6754.831129221809, 6789.388954994074, 6198.2871969722255, 6288.056791481315, 6291.213598300213, 6295.527835412271, 6298.275698294571, 4435.911281774411, 4566.931496027496, 4605.148047611203, 4694.577488025958, 4711.269753188261, 4480.955190448054, 4585.908281834411, 4631.675782695179, 4665.5567721066445, 4858.3441235432765], "value": 4035.386132683137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.51339007162994, 296.161861930736, 297.5046547498415, 298.5775128193606, 300.9563613276075, 4665.300204969256, 4782.795526996916, 4856.830010949613, 4865.805367785289, 4872.561469467747, 4676.929846052312, 4732.976335118328, 4745.311929770181, 4764.475907650156, 4812.759362031893, 3768.566614839301, 3769.227308401771, 3770.905727356824, 3781.432785082239, 3797.9430308545393, 3563.6436356364284, 3796.9810150949206, 3805.2009078093633, 3840.0783811885085, 3856.479375284343, 3611.855525778966, 3774.414965680324, 3776.546814382278, 3782.1490164712995, 3787.905302367449, 3747.882446417765, 3765.7761227600863, 3766.7551609145594, 3772.622737726233, 3773.584905660375, 3332.750043746729, 3335.34960682667, 3340.131565792887, 3343.331333733239, 3346.6987971082717, 4498.572635599646, 4655.301704744282, 4694.342792009122, 4707.505711900236, 4724.267738500538, 4240.915181696349, 4243.342281946303, 4248.596383343577, 4250.234957707611, 4251.298535741599, 5034.345535080416, 5038.748062596856, 5050.242463630448, 5061.848144555633, 5080.187170052811, 3436.398630239698, 3552.8401221945073, 3562.3765840977985, 3566.1262990567216, 3602.189507360823, 5188.896222075575, 5199.298094757235, 5206.687598744087, 5217.217417387385, 5218.66078704883, 3600.963990360115, 3607.260511595169, 3626.9818650906577, 3651.2332410193626, 3660.249648821985, 3515.402381595135, 3682.410814269704, 3684.613115622821, 3688.0595448161084, 3698.815059247027, 4217.873463796091, 4229.196452673982, 4230.936535951963, 4240.363945408213, 4257.893552661209, 5018.322526458881, 5028.522290382408, 5039.647224694236, 5065.772040258197, 5077.695338279715, 1200.9219400738923, 1242.1491278474275, 1270.9364531773374, 1285.794272916329, 1290.2774446309909, 833.9367306684027, 851.2594043182471, 856.8500512410303, 858.7853036740814, 861.0743450790426, 4418.60232579063, 4428.402165707588, 4442.244818380883, 4447.843560674248, 4454.175977444183, 5140.794368225229, 5152.227165925141, 5173.379194496684, 5177.326947496801, 5204.8959020819375, 4298.376735373354, 4373.671974601854, 4380.342948557678, 4405.224708433666, 4430.335449682573, 2402.49547595007, 2426.8593760932335, 2448.8285819992784, 2453.877306134686, 2454.104251948026, 4310.771430142394, 4322.675799315064, 4347.891302717458, 4349.847755328548, 4374.313392589621, 4494.280915053576, 4546.272596384562, 4631.305304204329, 4661.0, 4663.417072865892, 4299.527052024275, 4322.8703138905885, 4323.416338794348, 4332.328489084197, 4344.827586206897, 4563.0, 4567.2920697291975, 4577.382053422745, 4587.807170135722, 4602.2406302959635, 4495.57292057254, 4498.0104377037, 4506.954930450785, 4707.411573553306, 5128.256402821645, 4937.407511098691, 4948.727819969792, 4949.505049495022, 4952.950470495393, 4960.941209398059, 3661.469086982426, 3681.705463562962, 3690.686291665131, 3705.1478160023885, 3707.0, 5086.262491938722, 5287.339082614673, 5289.646107482134, 5299.046171689133, 5305.708186049805, 5050.722210278323, 5069.695818250917, 5082.593392528663, 5094.439611642791, 5107.438181800073, 5068.847934561969, 5085.618578606545, 5148.099082660594, 5190.948090519047, 5191.792328306977, 4857.1742803724155, 5005.524475174852, 5067.569256613229, 5070.0, 5080.237964305384, 5127.743612819269, 5143.8456846294675, 5156.922646160386, 5161.09680805865, 5164.638475306692, 5019.924701129559, 5031.572316353151, 5050.898982020412, 5060.898782024413, 5069.214271787879], "value": 3728.781484010316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.2532960447464, 626.8025571944837, 665.5507532415618, 710.2932582080828, 724.1780579042786, 13188.934055329722, 14459.421623135087, 14460.638484037905, 14465.493707720232, 14482.0, 13928.373223204955, 14051.086679365833, 14070.296485175726, 14075.718485630281, 14088.154710717365, 633.727497176214, 643.3919945651361, 759.9012128423325, 768.1205020251822, 783.1776634533717, 772.7643068863994, 782.8669126248523, 783.2676447521557, 783.3459061683473, 783.6708582395407, 825.162460102996, 826.3802148388709, 826.5454000299841, 827.0819390476566, 827.3711978896022, 657.7369052379087, 788.6884680551208, 815.2825513548099, 821.8808272800441, 822.2969361196181, 594.6699581732137, 598.3896425645817, 598.8083813179741, 601.0053361686416, 601.542827451136, 12977.480900763958, 13002.284874331908, 13004.869951300556, 13006.804897926539, 13025.804612930719, 12027.51889924402, 12394.31831249281, 12581.182223155558, 12776.936115319457, 13030.934845325713, 10171.64399246023, 10244.74388140295, 10365.326253793479, 10489.160867130611, 10522.526486308134, 4067.5118985721606, 4126.216018956388, 4135.813888375031, 4163.292240319153, 4281.293586558214, 60854.695726521524, 62461.37538624601, 62634.68682656603, 64352.0, 65080.3491965079, 9693.273004524688, 9697.854532182022, 9745.437892619977, 9853.655122070693, 9873.950630246803, 19179.424617261506, 19201.423957281302, 19204.231830726894, 19204.903975480313, 19214.423567293004, 6816.522843401013, 6857.348551887562, 6873.793786186422, 6890.2076261229595, 6894.172699276119, 3640.7997560134445, 3712.480252764615, 3719.739618226698, 3724.8510059597857, 3727.8508859645854, 2683.8926442942065, 2784.5127102756937, 2784.805063645566, 2785.874635641401, 2786.0, 457.5173192282108, 461.893764434182, 466.2702870008426, 471.00852705055365, 471.2154263151882, 417.7764895780743, 482.95894848938235, 489.5814078962507, 495.78185598336614, 496.5034965034965, 7676.961615191888, 7941.6029198539845, 7999.680012799539, 8115.79710507242, 8396.244338009486, 409.16368524046084, 428.38954489851835, 531.0573731626394, 532.6963630730446, 552.8811305569321, 3560.092176494977, 3658.9754868636824, 3680.3743363627714, 3762.2287431076566, 3934.9803250984132, 75035.0, 106695.0, 109508.4524577388, 112545.0, 113609.43195284136, 92050.0, 92684.53657731802, 95887.52056239813, 95998.52000739952, 97654.0, 83530.58234708788, 83795.5810220945, 84406.0, 84463.15536844675, 85122.0, 6915.204751453446, 7099.858002840017, 7168.103987001625, 7462.141853686679, 7637.923620763943, 47624.523754762005, 48825.5117448821, 49010.50989490059, 49818.0, 50124.74937625288, 38653.613463865004, 53985.0, 54047.189292161434, 55826.44173558213, 58092.0, 10539.262251642618, 10835.783284334428, 11107.111431085656, 11213.215074944676, 11438.71403214893, 12814.615561533168, 12866.0, 12993.285369304778, 13286.335683215993, 13461.798073029107, 12067.879321206676, 12232.87767122353, 12598.433070512032, 12761.298128603015, 12882.033847461666, 10779.461026948778, 11070.225084244348, 11139.443027848412, 11406.942965285121, 11655.0, 11675.532978680758, 11777.234479758788, 12608.117431779687, 12615.684607884876, 12622.11645184865, 9184.12750788674, 9361.812763744823, 9410.670626528039, 9719.951400243237, 9931.702048938543, 8572.314214862921, 9230.815383692154, 9639.500770722601, 9694.321397502106, 9839.212862970802], "value": 6505.851546633933, "unit": "score"}], "name": "dromaeo_css", "value": 6342.608425017357, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 112.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 126.0, 129.0, 184.0, 121.0, 123.0, 148.0, 120.0, 157.0, 124.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 109.0, 75.0, 77.0, 74.0, 75.0, 120.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 133.0, 84.0, 84.0, 85.0, 129.0, 85.0, 84.0, 132.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.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": [96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0, 63.0, 70.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 80.0, 79.0, 78.0, 78.0, 78.0, 79.0, 80.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 138.0, 131.0, 127.0, 129.0, 130.0, 128.0, 130.0, 154.0, 131.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 167.0, 167.0, 166.0, 171.0, 165.0, 165.0, 165.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 66.0, 67.0, 68.0, 66.0, 65.0, 65.0, 68.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1524.5000000000002, "alertThreshold": 2.0}]} 03:19:58 INFO - Return code: 0 03:19:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:58 INFO - # TBPL SUCCESS # 03:19:58 INFO - Running post-action listener: _resource_record_post_action 03:19:58 INFO - [mozharness: 2016-08-07 10:19:58.829521Z] Finished run-tests step (success) 03:19:58 INFO - Running post-run listener: _resource_record_post_run 03:19:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 344064; Write bytes: 285863936; Read time: 128; Write time: 214904 03:19:58 INFO - TinderboxPrint: CPU usage
13.0% 03:19:58 INFO - TinderboxPrint: I/O read bytes / time
344,064 / 128 03:19:58 INFO - TinderboxPrint: I/O write bytes / time
285,863,936 / 214,904 03:19:58 INFO - TinderboxPrint: CPU idle
8,326.3 (87.0%) 03:19:58 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 03:19:58 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 643072; Read time: 0; Write time: 52 03:19:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 339968; Write bytes: 285220864; Read time: 116; Write time: 214852 03:19:59 INFO - Running post-run listener: _upload_blobber_files 03:19:59 INFO - Blob upload gear active. 03:19:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:59 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 03:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:19:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:00 INFO - (blobuploader) - INFO - Done attempting. 03:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:01 INFO - (blobuploader) - INFO - Done attempting. 03:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:05 INFO - (blobuploader) - INFO - Done attempting. 03:20:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:05 INFO - Return code: 0 03:20:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6220db97c48cb5c4db2a5fc92271b4f6d058129a46850dc7e37278cee517351d1279bab52990fcc41b13fc98efabbf2d988e8ec13a444f726818416e9869a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57353b03aab6abcc1a43419d7372621a905aa0ac32305c0c7d0a0a9849a36076c1361630fe66acdb350f8295051a5c5a72191cbad4b7ae28f13fb4b42f619bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5318bc019156866d155b6887f25bf4470e7b5b1844e0cda41299fa78ee6fae95f41137b7313d69440554f0174bb446ee691792be29054ec3629a33406794aed5"} 03:20:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:05 INFO - Contents: 03:20:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6220db97c48cb5c4db2a5fc92271b4f6d058129a46850dc7e37278cee517351d1279bab52990fcc41b13fc98efabbf2d988e8ec13a444f726818416e9869a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57353b03aab6abcc1a43419d7372621a905aa0ac32305c0c7d0a0a9849a36076c1361630fe66acdb350f8295051a5c5a72191cbad4b7ae28f13fb4b42f619bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5318bc019156866d155b6887f25bf4470e7b5b1844e0cda41299fa78ee6fae95f41137b7313d69440554f0174bb446ee691792be29054ec3629a33406794aed5"} 03:20:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:05 INFO - Copying logs to upload dir... 03:20:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.752242 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-07 03:20:05.040977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:20:05.045602) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6220db97c48cb5c4db2a5fc92271b4f6d058129a46850dc7e37278cee517351d1279bab52990fcc41b13fc98efabbf2d988e8ec13a444f726818416e9869a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57353b03aab6abcc1a43419d7372621a905aa0ac32305c0c7d0a0a9849a36076c1361630fe66acdb350f8295051a5c5a72191cbad4b7ae28f13fb4b42f619bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5318bc019156866d155b6887f25bf4470e7b5b1844e0cda41299fa78ee6fae95f41137b7313d69440554f0174bb446ee691792be29054ec3629a33406794aed5"} build_url:https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/PIW58s__THmr_SVfSXe85g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6220db97c48cb5c4db2a5fc92271b4f6d058129a46850dc7e37278cee517351d1279bab52990fcc41b13fc98efabbf2d988e8ec13a444f726818416e9869a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57353b03aab6abcc1a43419d7372621a905aa0ac32305c0c7d0a0a9849a36076c1361630fe66acdb350f8295051a5c5a72191cbad4b7ae28f13fb4b42f619bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5318bc019156866d155b6887f25bf4470e7b5b1844e0cda41299fa78ee6fae95f41137b7313d69440554f0174bb446ee691792be29054ec3629a33406794aed5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:20:05.070560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:20:05.070864) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470561879.796299-731100657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:20:05.153813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:20:05.154116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:20:05.154383) ========= ========= Total master_lag: 0.52 =========