builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1462790935.94 results: success (0) buildid: 20160509024850 builduid: 19c9eb1de1f448e0a508eb57f0ef353e revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:55.942716) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:55.943185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:55.943513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:56.036726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:56.037074) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 03:48:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 492M=0s 2016-05-09 03:48:56 (492 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131180 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:56.219809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:56.220122) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047313 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:56.278816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 03:48:56.279225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb53cee341a60d134fd5dc55ead4a95632a22dce --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 cb53cee341a60d134fd5dc55ead4a95632a22dce --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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 03:48:56,329 truncating revision to first 12 chars 2016-05-09 03:48:56,329 Setting DEBUG logging. 2016-05-09 03:48:56,329 attempt 1/10 2016-05-09 03:48:56,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb53cee341a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 03:48:57,125 unpacking tar archive at: fx-team-cb53cee341a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.076369 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 03:48:57.368144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:57.368751) ========= script_repo_revision: cb53cee341a60d134fd5dc55ead4a95632a22dce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:57.369445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:57.369943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:48:57.381478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 44 secs) (at 2016-05-09 03:48:57.382105) ========= /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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:57 INFO - MultiFileLogger online at 20160509 03:48:57 in /builds/slave/test 03:48:57 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 03:48:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:57 INFO - {'append_to_log': False, 03:48:57 INFO - 'base_work_dir': '/builds/slave/test', 03:48:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:48:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:57 INFO - 'branch': 'Fx-Team-Non-PGO', 03:48:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:57 INFO - 'config_files': ('talos/linux_config.py',), 03:48:57 INFO - 'default_actions': ('clobber', 03:48:57 INFO - 'read-buildbot-config', 03:48:57 INFO - 'download-and-extract', 03:48:57 INFO - 'populate-webroot', 03:48:57 INFO - 'create-virtualenv', 03:48:57 INFO - 'install', 03:48:57 INFO - 'run-tests'), 03:48:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:57 INFO - 'download_minidump_stackwalk': True, 03:48:57 INFO - 'download_symbols': 'ondemand', 03:48:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:57 INFO - 'installer_path': 'installer.exe', 03:48:57 INFO - 'log_level': 'info', 03:48:57 INFO - 'log_name': 'talos', 03:48:57 INFO - 'log_to_console': True, 03:48:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:57 INFO - 'opt_config_files': (), 03:48:57 INFO - 'pip_index': False, 03:48:57 INFO - 'sps_profile': False, 03:48:57 INFO - 'sps_profile_interval': 0, 03:48:57 INFO - 'suite': 'dromaeojs', 03:48:57 INFO - 'system_bits': '32', 03:48:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:57 INFO - 'title': 'talos-linux64-ix-015', 03:48:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:57 INFO - 'use_talos_json': True, 03:48:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:57 INFO - 'work_dir': 'build'} 03:48:57 INFO - ##### 03:48:57 INFO - ##### Running clobber step. 03:48:57 INFO - ##### 03:48:57 INFO - Running pre-action listener: _resource_record_pre_action 03:48:57 INFO - Running main action method: clobber 03:48:57 INFO - rmtree: /builds/slave/test/build 03:48:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:58 INFO - Running post-action listener: _resource_record_post_action 03:48:58 INFO - ##### 03:48:58 INFO - ##### Finished clobber step (success) 03:48:58 INFO - ##### 03:48:58 INFO - ##### 03:48:58 INFO - ##### Running read-buildbot-config step. 03:48:58 INFO - ##### 03:48:58 INFO - Running pre-action listener: _resource_record_pre_action 03:48:58 INFO - Running main action method: read_buildbot_config 03:48:58 INFO - Using buildbot properties: 03:48:58 INFO - { 03:48:58 INFO - "project": "", 03:48:58 INFO - "product": "firefox", 03:48:58 INFO - "script_repo_revision": "production", 03:48:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:48:58 INFO - "repository": "", 03:48:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:48:58 INFO - "buildid": "20160509024850", 03:48:58 INFO - "pgo_build": "False", 03:48:58 INFO - "basedir": "/builds/slave/test", 03:48:58 INFO - "buildnumber": 2936, 03:48:58 INFO - "slavename": "talos-linux64-ix-015", 03:48:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:48:58 INFO - "platform": "ubuntu64_hw", 03:48:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:48:58 INFO - "branch": "fx-team", 03:48:58 INFO - "repo_path": "integration/fx-team", 03:48:58 INFO - "revision": "cb53cee341a60d134fd5dc55ead4a95632a22dce", 03:48:58 INFO - "stage_platform": "linux64", 03:48:58 INFO - "builduid": "19c9eb1de1f448e0a508eb57f0ef353e", 03:48:58 INFO - "slavebuilddir": "test" 03:48:58 INFO - } 03:48:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:48:58 INFO - Running post-action listener: _resource_record_post_action 03:48:58 INFO - ##### 03:48:58 INFO - ##### Finished read-buildbot-config step (success) 03:48:58 INFO - ##### 03:48:58 INFO - ##### 03:48:58 INFO - ##### Running download-and-extract step. 03:48:58 INFO - ##### 03:48:58 INFO - Running pre-action listener: _resource_record_pre_action 03:48:58 INFO - Running main action method: download_and_extract 03:48:58 INFO - mkdir: /builds/slave/test/build/tests 03:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:58 INFO - https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:48:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:48:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:48:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:48:59 INFO - Downloaded 1361 bytes. 03:48:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:48:59 INFO - Using the following test package requirements: 03:48:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:48:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'jsshell-linux-x86_64.zip'], 03:48:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:59 INFO - https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:00 INFO - Downloaded 22322863 bytes. 03:49:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:49:01 INFO - Return code: 0 03:49:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:01 INFO - https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:49:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:49:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:49:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:03 INFO - Downloaded 22322863 bytes. 03:49:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:49:04 INFO - Return code: 0 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:04 INFO - https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:05 INFO - Downloaded 10840152 bytes. 03:49:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:49:06 INFO - Return code: 0 03:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:06 INFO - https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:49:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:49:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:49:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:49:07 INFO - Downloaded 54857342 bytes. 03:49:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:49:07 INFO - mkdir: /builds/slave/test/properties 03:49:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:07 INFO - Contents: 03:49:07 INFO - build_url:https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:49:08 INFO - Running post-action listener: _resource_record_post_action 03:49:08 INFO - Running post-action listener: set_extra_try_arguments 03:49:08 INFO - ##### 03:49:08 INFO - ##### Finished download-and-extract step (success) 03:49:08 INFO - ##### 03:49:08 INFO - ##### 03:49:08 INFO - ##### Running populate-webroot step. 03:49:08 INFO - ##### 03:49:08 INFO - Running pre-action listener: _resource_record_pre_action 03:49:08 INFO - Running main action method: populate_webroot 03:49:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:49:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:49:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:49:08 INFO - '--tppagecycles', 03:49:08 INFO - '7'], 03:49:08 INFO - 'tests': ['tsvgm']}}, 03:49:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:49:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:49:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:49:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:49:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['damp', 'tps']}, 03:49:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'tests': ['damp', 'tps']}, 03:49:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['dromaeo_dom']}, 03:49:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['a11yr', 03:49:08 INFO - 'ts_paint', 03:49:08 INFO - 'tpaint', 03:49:08 INFO - 'sessionrestore', 03:49:08 INFO - 'sessionrestore_no_auto_restore', 03:49:08 INFO - 'tabpaint']}, 03:49:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['tsvgx', 03:49:08 INFO - 'tsvgr_opacity', 03:49:08 INFO - 'tart', 03:49:08 INFO - 'tscrollx', 03:49:08 INFO - 'cart']}, 03:49:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:49:08 INFO - 'tsvgr_opacity', 03:49:08 INFO - 'tart', 03:49:08 INFO - 'tscrollx', 03:49:08 INFO - 'cart']}, 03:49:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'talos_options': ['--disable-e10s'], 03:49:08 INFO - 'tests': ['tp5o']}, 03:49:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'tests': ['tp5o']}, 03:49:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'talos_options': ['--disable-e10s', 03:49:08 INFO - '--xperf_path', 03:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:08 INFO - 'tests': ['tp5n']}, 03:49:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:08 INFO - 'talos_options': ['--xperf_path', 03:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:08 INFO - 'tests': ['tp5n']}}, 03:49:08 INFO - 'talos.zip': {'path': '', 03:49:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:49:08 INFO - Running post-action listener: _resource_record_post_action 03:49:08 INFO - ##### 03:49:08 INFO - ##### Finished populate-webroot step (success) 03:49:08 INFO - ##### 03:49:08 INFO - ##### 03:49:08 INFO - ##### Running create-virtualenv step. 03:49:08 INFO - ##### 03:49:08 INFO - Running pre-action listener: _resource_record_pre_action 03:49:08 INFO - Running main action method: create_virtualenv 03:49:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:49:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:49:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:08 INFO - Using real prefix '/usr' 03:49:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:11 INFO - Installing pip.................done. 03:49:11 INFO - Return code: 0 03:49:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:49:11 INFO - Using env: {'DISPLAY': ':0', 03:49:11 INFO - 'HOME': '/home/cltbld', 03:49:11 INFO - 'LANG': 'en_US.UTF-8', 03:49:11 INFO - 'LANGUAGE': 'en_US:en', 03:49:11 INFO - 'LOGNAME': 'cltbld', 03:49:11 INFO - 'MAIL': '/var/mail/cltbld', 03:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:11 INFO - 'MOZ_NO_REMOTE': '1', 03:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:11 INFO - 'NO_EM_RESTART': '1', 03:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:11 INFO - 'PWD': '/builds/slave/test', 03:49:11 INFO - 'SHELL': '/bin/bash', 03:49:11 INFO - 'SHLVL': '1', 03:49:11 INFO - 'TERM': 'linux', 03:49:11 INFO - 'TMOUT': '86400', 03:49:11 INFO - 'USER': 'cltbld', 03:49:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:11 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:12 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 03:49:12 INFO - Cleaning up... 03:49:12 INFO - Return code: 0 03:49:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:12 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>=0.7.1'] in /builds/slave/test/build 03:49:12 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>=0.7.1 03:49:12 INFO - Using env: {'DISPLAY': ':0', 03:49:12 INFO - 'HOME': '/home/cltbld', 03:49:12 INFO - 'LANG': 'en_US.UTF-8', 03:49:12 INFO - 'LANGUAGE': 'en_US:en', 03:49:12 INFO - 'LOGNAME': 'cltbld', 03:49:12 INFO - 'MAIL': '/var/mail/cltbld', 03:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:12 INFO - 'MOZ_NO_REMOTE': '1', 03:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:12 INFO - 'NO_EM_RESTART': '1', 03:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:12 INFO - 'PWD': '/builds/slave/test', 03:49:12 INFO - 'SHELL': '/bin/bash', 03:49:12 INFO - 'SHLVL': '1', 03:49:12 INFO - 'TERM': 'linux', 03:49:12 INFO - 'TMOUT': '86400', 03:49:12 INFO - 'USER': 'cltbld', 03:49:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:12 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:12 INFO - Downloading/unpacking psutil>=0.7.1 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:14 INFO - Installing collected packages: psutil 03:49:14 INFO - Running setup.py install for psutil 03:49:14 INFO - building 'psutil._psutil_linux' extension 03:49:14 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 03:49:16 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 03:49:16 INFO - building 'psutil._psutil_posix' extension 03:49:16 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 03:49:16 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 03:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:17 INFO - Successfully installed psutil 03:49:17 INFO - Cleaning up... 03:49:17 INFO - Return code: 0 03:49:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:17 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:17 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.0.0'] in /builds/slave/test/build 03:49:17 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.0.0 03:49:17 INFO - Using env: {'DISPLAY': ':0', 03:49:17 INFO - 'HOME': '/home/cltbld', 03:49:17 INFO - 'LANG': 'en_US.UTF-8', 03:49:17 INFO - 'LANGUAGE': 'en_US:en', 03:49:17 INFO - 'LOGNAME': 'cltbld', 03:49:17 INFO - 'MAIL': '/var/mail/cltbld', 03:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:17 INFO - 'MOZ_NO_REMOTE': '1', 03:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:17 INFO - 'NO_EM_RESTART': '1', 03:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:17 INFO - 'PWD': '/builds/slave/test', 03:49:17 INFO - 'SHELL': '/bin/bash', 03:49:17 INFO - 'SHLVL': '1', 03:49:17 INFO - 'TERM': 'linux', 03:49:17 INFO - 'TMOUT': '86400', 03:49:17 INFO - 'USER': 'cltbld', 03:49:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:17 INFO - '_': '/tools/buildbot/bin/python'} 03:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:49:19 INFO - Installing collected packages: mozsystemmonitor 03:49:19 INFO - Running setup.py install for mozsystemmonitor 03:49:19 INFO - Successfully installed mozsystemmonitor 03:49:19 INFO - Cleaning up... 03:49:19 INFO - Return code: 0 03:49:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:19 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 03:49:19 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 03:49:19 INFO - Using env: {'DISPLAY': ':0', 03:49:19 INFO - 'HOME': '/home/cltbld', 03:49:19 INFO - 'LANG': 'en_US.UTF-8', 03:49:19 INFO - 'LANGUAGE': 'en_US:en', 03:49:19 INFO - 'LOGNAME': 'cltbld', 03:49:19 INFO - 'MAIL': '/var/mail/cltbld', 03:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:19 INFO - 'MOZ_NO_REMOTE': '1', 03:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:19 INFO - 'NO_EM_RESTART': '1', 03:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:19 INFO - 'PWD': '/builds/slave/test', 03:49:19 INFO - 'SHELL': '/bin/bash', 03:49:19 INFO - 'SHLVL': '1', 03:49:19 INFO - 'TERM': 'linux', 03:49:19 INFO - 'TMOUT': '86400', 03:49:19 INFO - 'USER': 'cltbld', 03:49:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:19 INFO - '_': '/tools/buildbot/bin/python'} 03:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:19 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:21 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 INFO - Downloading docopt-0.6.1.tar.gz 03:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:22 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:22 INFO - Running setup.py install for blobuploader 03:49:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:22 INFO - Running setup.py install for requests 03:49:22 INFO - Running setup.py install for docopt 03:49:22 INFO - Successfully installed blobuploader requests docopt 03:49:22 INFO - Cleaning up... 03:49:22 INFO - Return code: 0 03:49:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:49:22 INFO - Using env: {'DISPLAY': ':0', 03:49:22 INFO - 'HOME': '/home/cltbld', 03:49:22 INFO - 'LANG': 'en_US.UTF-8', 03:49:22 INFO - 'LANGUAGE': 'en_US:en', 03:49:22 INFO - 'LOGNAME': 'cltbld', 03:49:22 INFO - 'MAIL': '/var/mail/cltbld', 03:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:22 INFO - 'MOZ_NO_REMOTE': '1', 03:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:22 INFO - 'NO_EM_RESTART': '1', 03:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:22 INFO - 'PWD': '/builds/slave/test', 03:49:22 INFO - 'SHELL': '/bin/bash', 03:49:22 INFO - 'SHLVL': '1', 03:49:22 INFO - 'TERM': 'linux', 03:49:22 INFO - 'TMOUT': '86400', 03:49:22 INFO - 'USER': 'cltbld', 03:49:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:22 INFO - '_': '/tools/buildbot/bin/python'} 03:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:23 INFO - Running setup.py (path:/tmp/pip-CYDTpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:23 INFO - Running setup.py (path:/tmp/pip-DpihB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:23 INFO - Running setup.py (path:/tmp/pip-a6zf93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:23 INFO - Running setup.py (path:/tmp/pip-0cizYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:23 INFO - Running setup.py (path:/tmp/pip-u6m6PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:23 INFO - Running setup.py (path:/tmp/pip-HKo6WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:23 INFO - Running setup.py (path:/tmp/pip-saaKlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:23 INFO - Running setup.py (path:/tmp/pip-hQvPtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:23 INFO - Running setup.py (path:/tmp/pip-BBAQ9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:23 INFO - Running setup.py (path:/tmp/pip-YZyQHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:23 INFO - Running setup.py (path:/tmp/pip-tsVsPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:23 INFO - Running setup.py (path:/tmp/pip-7RmH8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:23 INFO - Running setup.py (path:/tmp/pip-duwv6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:24 INFO - Running setup.py (path:/tmp/pip-RY5fJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:24 INFO - Running setup.py (path:/tmp/pip-fMtLb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:24 INFO - Running setup.py (path:/tmp/pip-5IrM4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:24 INFO - Running setup.py (path:/tmp/pip-OM87yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:24 INFO - Running setup.py install for manifestparser 03:49:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:49:24 INFO - Running setup.py install for mozcrash 03:49:24 INFO - Running setup.py install for mozdebug 03:49:24 INFO - Running setup.py install for mozdevice 03:49:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:49:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:49:24 INFO - Running setup.py install for mozfile 03:49:24 INFO - Running setup.py install for mozhttpd 03:49:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:49:24 INFO - Running setup.py install for mozinfo 03:49:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for mozInstall 03:49:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for mozleak 03:49:25 INFO - Running setup.py install for mozlog 03:49:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for moznetwork 03:49:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for mozprocess 03:49:25 INFO - Running setup.py install for mozprofile 03:49:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for mozrunner 03:49:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:25 INFO - Running setup.py install for mozscreenshot 03:49:25 INFO - Running setup.py install for moztest 03:49:25 INFO - Running setup.py install for mozversion 03:49:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:26 INFO - Cleaning up... 03:49:26 INFO - Return code: 0 03:49:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:26 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 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:26 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 03:49:26 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 03:49:26 INFO - Using env: {'DISPLAY': ':0', 03:49:26 INFO - 'HOME': '/home/cltbld', 03:49:26 INFO - 'LANG': 'en_US.UTF-8', 03:49:26 INFO - 'LANGUAGE': 'en_US:en', 03:49:26 INFO - 'LOGNAME': 'cltbld', 03:49:26 INFO - 'MAIL': '/var/mail/cltbld', 03:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:26 INFO - 'MOZ_NO_REMOTE': '1', 03:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:26 INFO - 'NO_EM_RESTART': '1', 03:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:26 INFO - 'PWD': '/builds/slave/test', 03:49:26 INFO - 'SHELL': '/bin/bash', 03:49:26 INFO - 'SHLVL': '1', 03:49:26 INFO - 'TERM': 'linux', 03:49:26 INFO - 'TMOUT': '86400', 03:49:26 INFO - 'USER': 'cltbld', 03:49:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:26 INFO - '_': '/tools/buildbot/bin/python'} 03:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:26 INFO - Running setup.py (path:/tmp/pip-_7opIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:26 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)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:26 INFO - Running setup.py (path:/tmp/pip-tV9HIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:26 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)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:26 INFO - Running setup.py (path:/tmp/pip-e5rZnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:26 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)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:26 INFO - Running setup.py (path:/tmp/pip-fB8Urh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:26 INFO - Running setup.py (path:/tmp/pip-sGkkOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:26 INFO - Running setup.py (path:/tmp/pip-Cdpfyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:26 INFO - Running setup.py (path:/tmp/pip-5A3Lwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:26 INFO - Running setup.py (path:/tmp/pip-PSrmBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:26 INFO - Running setup.py (path:/tmp/pip-aemaLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:26 INFO - Running setup.py (path:/tmp/pip-gOTgru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:27 INFO - Running setup.py (path:/tmp/pip-VfEBn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:27 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)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:27 INFO - Running setup.py (path:/tmp/pip-JMApDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:27 INFO - Running setup.py (path:/tmp/pip-2cXBAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:27 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)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:27 INFO - Running setup.py (path:/tmp/pip-EbcxoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:27 INFO - Running setup.py (path:/tmp/pip-yVIsY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:27 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)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:27 INFO - Running setup.py (path:/tmp/pip-uYwUhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:27 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)) 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:27 INFO - Running setup.py (path:/tmp/pip-rK4IWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:29 INFO - Downloading blessings-1.6.tar.gz 03:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:29 INFO - Installing collected packages: blessings 03:49:29 INFO - Running setup.py install for blessings 03:49:29 INFO - Successfully installed blessings 03:49:29 INFO - Cleaning up... 03:49:29 INFO - Return code: 0 03:49:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:29 INFO - Reading from file tmpfile_stdout 03:49:29 INFO - Current package versions: 03:49:29 INFO - argparse == 1.2.1 03:49:29 INFO - blessings == 1.6 03:49:29 INFO - blobuploader == 1.2.4 03:49:29 INFO - docopt == 0.6.1 03:49:29 INFO - manifestparser == 1.1 03:49:29 INFO - mozInstall == 1.12 03:49:29 INFO - mozcrash == 0.17 03:49:29 INFO - mozdebug == 0.1 03:49:29 INFO - mozdevice == 0.48 03:49:29 INFO - mozfile == 1.2 03:49:29 INFO - mozhttpd == 0.7 03:49:29 INFO - mozinfo == 0.9 03:49:29 INFO - mozleak == 0.1 03:49:29 INFO - mozlog == 3.1 03:49:29 INFO - moznetwork == 0.27 03:49:29 INFO - mozprocess == 0.22 03:49:29 INFO - mozprofile == 0.28 03:49:29 INFO - mozrunner == 6.11 03:49:29 INFO - mozscreenshot == 0.1 03:49:29 INFO - mozsystemmonitor == 0.0 03:49:29 INFO - moztest == 0.7 03:49:29 INFO - mozversion == 1.4 03:49:29 INFO - psutil == 3.1.1 03:49:29 INFO - requests == 1.2.3 03:49:29 INFO - wsgiref == 0.1.2 03:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:49:29 INFO - Using env: {'DISPLAY': ':0', 03:49:29 INFO - 'HOME': '/home/cltbld', 03:49:29 INFO - 'LANG': 'en_US.UTF-8', 03:49:29 INFO - 'LANGUAGE': 'en_US:en', 03:49:29 INFO - 'LOGNAME': 'cltbld', 03:49:29 INFO - 'MAIL': '/var/mail/cltbld', 03:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:29 INFO - 'MOZ_NO_REMOTE': '1', 03:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:29 INFO - 'NO_EM_RESTART': '1', 03:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:29 INFO - 'PWD': '/builds/slave/test', 03:49:29 INFO - 'SHELL': '/bin/bash', 03:49:29 INFO - 'SHLVL': '1', 03:49:29 INFO - 'TERM': 'linux', 03:49:29 INFO - 'TMOUT': '86400', 03:49:29 INFO - 'USER': 'cltbld', 03:49:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:29 INFO - '_': '/tools/buildbot/bin/python'} 03:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 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)) 03:49:30 INFO - Cleaning up... 03:49:30 INFO - Return code: 0 03:49:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:30 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 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:30 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 03:49:30 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 03:49:30 INFO - Using env: {'DISPLAY': ':0', 03:49:30 INFO - 'HOME': '/home/cltbld', 03:49:30 INFO - 'LANG': 'en_US.UTF-8', 03:49:30 INFO - 'LANGUAGE': 'en_US:en', 03:49:30 INFO - 'LOGNAME': 'cltbld', 03:49:30 INFO - 'MAIL': '/var/mail/cltbld', 03:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:30 INFO - 'MOZ_NO_REMOTE': '1', 03:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:30 INFO - 'NO_EM_RESTART': '1', 03:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:30 INFO - 'PWD': '/builds/slave/test', 03:49:30 INFO - 'SHELL': '/bin/bash', 03:49:30 INFO - 'SHLVL': '1', 03:49:30 INFO - 'TERM': 'linux', 03:49:30 INFO - 'TMOUT': '86400', 03:49:30 INFO - 'USER': 'cltbld', 03:49:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:30 INFO - '_': '/tools/buildbot/bin/python'} 03:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:30 INFO - Downloading/unpacking jsonschema 03:49:30 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 03:49:30 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 03:49:30 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 03:49:30 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 03:49:30 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 03:49:30 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 03:49:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:32 INFO - Downloading/unpacking functools32 (from jsonschema) 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:32 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:32 INFO - warning: no files found matching '*.txt' 03:49:32 INFO - no previously-included directories found matching 'build' 03:49:32 INFO - no previously-included directories found matching 'dist' 03:49:32 INFO - no previously-included directories found matching '.git*' 03:49:32 INFO - Installing collected packages: jsonschema, functools32 03:49:32 INFO - Running setup.py install for functools32 03:49:32 INFO - warning: no files found matching '*.txt' 03:49:32 INFO - no previously-included directories found matching 'build' 03:49:32 INFO - no previously-included directories found matching 'dist' 03:49:32 INFO - no previously-included directories found matching '.git*' 03:49:32 INFO - Successfully installed jsonschema functools32 03:49:32 INFO - Cleaning up... 03:49:32 INFO - Return code: 0 03:49:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa35eab8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, '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': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', '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 03:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:49:32 INFO - Using env: {'DISPLAY': ':0', 03:49:32 INFO - 'HOME': '/home/cltbld', 03:49:32 INFO - 'LANG': 'en_US.UTF-8', 03:49:32 INFO - 'LANGUAGE': 'en_US:en', 03:49:32 INFO - 'LOGNAME': 'cltbld', 03:49:32 INFO - 'MAIL': '/var/mail/cltbld', 03:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:32 INFO - 'MOZ_NO_REMOTE': '1', 03:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:32 INFO - 'NO_EM_RESTART': '1', 03:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:32 INFO - 'PWD': '/builds/slave/test', 03:49:32 INFO - 'SHELL': '/bin/bash', 03:49:32 INFO - 'SHLVL': '1', 03:49:32 INFO - 'TERM': 'linux', 03:49:32 INFO - 'TMOUT': '86400', 03:49:32 INFO - 'USER': 'cltbld', 03:49:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:32 INFO - '_': '/tools/buildbot/bin/python'} 03:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:32 INFO - Downloading/unpacking flake8 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:49:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:49:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:34 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 03:49:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:35 INFO - no previously-included directories found matching 'docs/_build' 03:49:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:49:35 INFO - Running setup.py install for pep8 03:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:35 INFO - no previously-included directories found matching 'docs/_build' 03:49:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:49:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:49:35 INFO - Cleaning up... 03:49:35 INFO - Return code: 0 03:49:35 INFO - Running post-action listener: _resource_record_post_action 03:49:35 INFO - Running post-action listener: _start_resource_monitoring 03:49:35 INFO - Starting resource monitoring. 03:49:35 INFO - ##### 03:49:35 INFO - ##### Finished create-virtualenv step (success) 03:49:35 INFO - ##### 03:49:35 INFO - ##### 03:49:35 INFO - ##### Running install step. 03:49:35 INFO - ##### 03:49:35 INFO - Running pre-action listener: _resource_record_pre_action 03:49:35 INFO - Running main action method: install 03:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:35 INFO - Reading from file tmpfile_stdout 03:49:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:36 INFO - Reading from file tmpfile_stdout 03:49:36 INFO - Output received: 03:49:36 INFO - Usage: mozinstall [options] installer 03:49:36 INFO - Options: 03:49:36 INFO - -h, --help show this help message and exit 03:49:36 INFO - -d DEST, --destination=DEST 03:49:36 INFO - Directory to install application into. [default: 03:49:36 INFO - "/builds/slave/test"] 03:49:36 INFO - --app=APP Application being installed. [default: firefox] 03:49:36 INFO - mkdir: /builds/slave/test/build/application 03:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:49:51 INFO - Reading from file tmpfile_stdout 03:49:51 INFO - Output received: 03:49:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - ##### 03:49:51 INFO - ##### Finished install step (success) 03:49:51 INFO - ##### 03:49:51 INFO - ##### 03:49:51 INFO - ##### Running run-tests step. 03:49:51 INFO - ##### 03:49:51 INFO - Running pre-action listener: _resource_record_pre_action 03:49:51 INFO - Running main action method: run_tests 03:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:51 INFO - Python 2.7.3 03:49:51 INFO - Return code: 0 03:49:51 INFO - grabbing minidump binary from tooltool 03:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:51 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba99c0>, '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 0x1baa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:51 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:49:51 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:49:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:51 INFO - Return code: 0 03:49:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:49:52 INFO - Return code: 0 03:49:52 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/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:49:52 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/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:49:52 INFO - Using env: {'DISPLAY': ':0', 03:49:52 INFO - 'HOME': '/home/cltbld', 03:49:52 INFO - 'LANG': 'en_US.UTF-8', 03:49:52 INFO - 'LANGUAGE': 'en_US:en', 03:49:52 INFO - 'LOGNAME': 'cltbld', 03:49:52 INFO - 'MAIL': '/var/mail/cltbld', 03:49:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:52 INFO - 'MOZ_NO_REMOTE': '1', 03:49:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:52 INFO - 'NO_EM_RESTART': '1', 03:49:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:52 INFO - 'PWD': '/builds/slave/test', 03:49:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:52 INFO - 'SHELL': '/bin/bash', 03:49:52 INFO - 'SHLVL': '1', 03:49:52 INFO - 'TERM': 'linux', 03:49:52 INFO - 'TMOUT': '86400', 03:49:52 INFO - 'USER': 'cltbld', 03:49:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883', 03:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:52 INFO - '_': '/tools/buildbot/bin/python'} 03:49:52 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/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:49:53 INFO - mozversion application_buildid: 20160509024850 03:49:53 INFO - mozversion application_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 03:49:53 INFO - mozversion application_display_name: Nightly 03:49:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:53 INFO - mozversion application_name: Firefox 03:49:53 INFO - mozversion application_remotingname: firefox 03:49:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:53 INFO - mozversion application_vendor: Mozilla 03:49:53 INFO - mozversion application_version: 49.0a1 03:49:53 INFO - mozversion platform_buildid: 20160509024850 03:49:53 INFO - mozversion platform_changeset: cb53cee341a60d134fd5dc55ead4a95632a22dce 03:49:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:53 INFO - mozversion platform_version: 49.0a1 03:49:53 INFO - using testdate: 1462790993 03:49:53 INFO - actual date: 1462790993 03:49:53 INFO - starting webserver on 'localhost:60784' 03:49:53 INFO - SUITE-START | Running 2 tests 03:49:53 INFO - TEST-START | dromaeo_css 03:49:53 INFO - operating with platform_type : linux_ 03:49:53 INFO - Initialising browser for dromaeo_css test... 03:49:53 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCyQ8p/profile http://localhost:60784/getInfo.html) 03:49:58 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 03:49:58 INFO - PROCESS | 3317 | colorDepth:24 03:49:58 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 03:49:58 INFO - PROCESS | 3317 | __metrics 03:50:00 ERROR - PROCESS | 3317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:00 INFO - TEST-INFO | 3317: exit 0 03:50:00 INFO - Browser initialized. 03:50:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:00 INFO - TEST-INFO | started process 3400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCyQ8p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:12 INFO - PROCESS | 3400 | RSS: Main: 153825280 03:50:12 INFO - PROCESS | 3400 | 03:51:04 INFO - PROCESS | 3400 | 1462791064202 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:53:16 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60784/tests/dromaeo/cssquery-ext.html) 03:53:17 INFO - PROCESS | 3400 | RSS: Main: 245256192 03:53:17 INFO - PROCESS | 3400 | 03:56:20 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-ext.html (next: http://localhost:60784/tests/dromaeo/cssquery-jquery.html) 03:56:20 INFO - PROCESS | 3400 | RSS: Main: 233181184 03:56:20 INFO - PROCESS | 3400 | 03:59:22 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60784/tests/dromaeo/cssquery-mootools.html) 03:59:23 INFO - PROCESS | 3400 | RSS: Main: 234811392 03:59:23 INFO - PROCESS | 3400 | 04:02:25 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60784/tests/dromaeo/cssquery-prototype.html) 04:02:26 INFO - PROCESS | 3400 | RSS: Main: 232017920 04:02:26 INFO - PROCESS | 3400 | 04:05:29 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60784/tests/dromaeo/cssquery-yui.html) 04:05:29 INFO - PROCESS | 3400 | RSS: Main: 210591744 04:05:29 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:60784/tests/dromaeo/cssquery-yui.html (next: http://localhost:60784/tests/dromaeo/cssquery-dojo.html) 04:08:32 INFO - PROCESS | 3400 | RSS: Main: 278794240 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | __start_tp_report 04:08:32 INFO - PROCESS | 3400 | _x_x_mozilla_page_load 04:08:32 INFO - PROCESS | 3400 | _x_x_mozilla_page_load_details 04:08:32 INFO - PROCESS | 3400 | |i|pagename|runs| 04:08:32 INFO - PROCESS | 3400 | |0;dojo.html;2676.5717485202367;2692.488427198831;2721.455708858228;2723.8910443582263;2740.1231605886123;4576.7025143365745;4644.349791029259;4703.129920964624;4797.616190704748;4822.469528351883;4664.3936288282475;4679.555442232991;4694.507076756942;4746.098241334144;4806.639502037352;4318.157959197958;4331.242032644291;4374.759388233661;4401.735895846244;4403.273459879116;4347.760873151976;4459.15276097542;4499.640028797705;4516.345129956171;4539.59143677069;4425.424694789656;4430.778461076933;4467.463904331485;4481.170983368087;4538.7503687297185;4201.663866890672;4250.978745106255;4267.0825772459075;4313.935290970638;4321.308590625485;4273.551277115889;4273.850415235483;4295.076558539929;4299.14017196562;4305.5694430557005;4555.020670555813;4578.931316030262;4644.58198762113;4649.418822647169;4654.604358629521;5082.161443361841;5088.4148322942965;5130.871728206825;5136.614753893473;5141.948580514222;4893.75531223441;5093.694378337274;5112.744362781883;5155.9742201288755;5170.431252562215;4833.226683730586;4837;4837.105135549935;4875.780589873464;4881.731504767236;5274.947250527523;5275.815346462856;5278.234655974862;5318.12250978592;5321.494458026481;4875.07373599015;4920.729359885169;4964.851054468371;4980.5019498049905;5036.0179764946215;5022.472640372781;5042.067217564762;5049.823256186016;5061;5099.9490005100215;4886.413630364308;4998.275250088789;5009.949900500948;5022.2466630005065;5024.698518088926;4906.092372911023;5006.824761133343;5056.115179843513;5066.06277838601;5100.260462232955;4380.9123817524105;4385.7149285296355;4386.429764130707;4387.232234359039;4428.557144285545;3813.237352529505;3836.5396152461885;3849.576546579874;3853.2871418787613;3866.845326186977;4207.095474473003;4211.494620645542;4240.830366785356;4277.636400905895;4292.034292284211;5031.069252188357;5042.7982880685095;5060.1903695408555;5062.341895553628;5107.310513080686;4300;4302.09655972243;4302.204092242945;4302.526722060571;4348.7390756554705;4479.417675702138;4545.090981803586;4568.954310456919;4585.220512512881;4590.449146102489;4753.881152971203;4765.404324459512;4770.6183505318795;4779.880502987453;4821.855344339676;4972.975135124301;5031.572316353151;5064.392272927125;5073.137566613611;5120.667156634807;4762.666613337172;4799.568038876518;4820.373351464287;4823.131836269506;4842.176829938849;5026.321446604661;5049.23225571882;5055.974720126376;5056.292119103255;5112.897742045064;4841.515848415131;5066.82266120684;5090.821821236239;5104.591632669451;5176.637635365489;4939.061578300111;4980.750962451935;5001.57486613642;5001.974990125172;5056.191009438472;4976.825811096594;4987.077390682735;4990.8003679853855;4994.02616489781;5046.495350464924;4698.506656800987;4768;4794.472608013186;4934.18585933317;5001.099802035668;4901.240307752304;4913.484084171254;4927.581155601814;4932.482089380707;4963.478834722302;4835.830745923876;4837.032593481388;4841.685290456109;4882.145624515624;4892.92660610084 04:08:32 INFO - PROCESS | 3400 | |1;ext.html;581.0789898011651;602.1750202222955;602.7257597793005;610.6214147228719;622.2812651387646;27188.864055679744;30312.696873031262;30347.241318967008;43950.7802460988;44703.77648111763;43653.56346436535;43760.343594846105;43927.560724392744;44105.55894441055;44154.33768493467;7360.779176624683;7806.102298235691;7955.363570914313;7960.323372513343;7965.8805117923275;7405.518641288299;7662.233776622349;7665.616719164047;10081.09270165685;10360.740981475448;10237.488125593727;10306.072453479223;10316.742081447986;10317.277790554665;10323;10213.182945364353;10293.485325733758;10294.073533381994;10297.07326340633;10297.9485102574;7497.250274972514;7732.4200684948855;7735.651895664709;9788.21694264457;10214.744631384201;39588.60411395907;39980.40029399561;40054.799726001474;40073.79963100166;40127.39808902869;3223.1136437479645;3284.0640417480904;3316.668333166688;3433.4334834752235;3522.348365552381;29521.557176642367;29873.70126298731;30281.091567253017;30515.542266866014;30624;3119.2825650100604;3219.2273854274804;3223.2425380035675;3287.96712032879;3315.1380641033265;178027;178371;178777;178933;180076;56973.71513142408;57271.42728572744;57289.713551431974;57336.426635733944;57339.13991290134;35659.4651080234;36656.45015324772;36720.26559468795;38711;38728.225435491695;14805.777913331309;14955.40178392852;15015.399384024735;15024.399024039134;15031.323590438456;9044.547772611342;11146.331220126818;11290.604828831116;11290.774184516264;11294.152938529644;19331.02015231451;20892.85089320102;20928.267510637055;20995.47511312199;21008.73947563151;7144.821379465555;7275.236100209508;7356.448266380043;7381.224971378036;7406.296401841816;909.9226565741853;928.5310917986374;966.2946049383849;967.02330646048;995.7311525888115;28299.43401131966;29296.56055159174;29371.27168351429;29416.852915735286;29727.554086688717;1034.9948250258851;1039.3348257115451;1049.5801679328329;1050.558765318568;1105.6240878101485;15397.923010384877;15657.608559786097;15711.371545138296;15725.528234152993;16142.515724528283;385800;388109;388613;389822;391095;51678.741606291725;52215.216771748455;52343.21485177725;52543.73728131411;52546.73726631419;1152.176194021279;1271.3770252576355;1284.1139613666726;1288.6391810293132;1291.8772716592098;28515.28711782222;29254.7074529252;29763.70236297696;30363;30379.2405189872;44520.554794451644;45060.77469612631;45084.54915450804;45098.323525146494;45098.3235251478;289611;290783;291310;291386;292278;22814.543709126057;26156.215313540622;27046.864765676044;27209.31976700598;28368.148955531367;42509;43353;43601.56398436102;43999.340009900516;44449.77775111104;37161.814190928875;37303.626963730014;37668.24663506769;37823.62176378201;38198.61801382062;36681.862504887235;37050.6294937058;37479.25041499209;37533.81233093817;37654.2469150621;36804.447933280484;41310;42008.369874451295;42906.78546607247;46119;36927.54085610967;40692;41165.79417102895;41455.37816932809;41490.792546037075;30609.54085688761;31399.21501962469;31441.21396965094;31468.213294667818;32205.194870128435 04:08:32 INFO - PROCESS | 3400 | |2;jquery.html;356.29275887363576;357.3888650407803;358.0547354982845;374.4271264964605;378.1661436532446;16179;17654.73517897231;17703.91148044258;18051.458456246335;18183.636327273463;17207;17230.655386892253;17476;17929.282828686835;17934.820651793478;5053.873653158673;5171.327727395452;5236.2931004314505;5254.4220135785035;5262.236975638531;3692.1877187018813;5040.7731652075745;5208.791648334062;6071.3625069367745;6073.726682299307;5997.61015533991;6101.054336577816;6116.7553297868035;6128.479079278267;6129.233845769279;5964.1650168976375;6058.636481811083;6100.938990610081;6180.351063138396;6190.969045154768;5242.842714718565;5244.29202057725;5245;5250.684958902478;5250.7112108834;11120.61077862271;11622.94188529052;11632.651020469399;11957.820632690517;11962.82055769164;2056.629806634805;2060.8969551522364;2145.6566949288194;2394.736578976311;2517.748225177486;9144.45133291998;9545.761355966088;9571.617135314578;9999.75000624983;13032.934835325763;1773.122304459288;1804.7563578916809;1830.6430246102016;1872.6348362069402;1875.5404925793268;62895.68552157256;69970.3002969969;70490;70588.29411705869;71670;9129.45223286605;9175.54122293896;9190.40262382943;9200.6779762708;9314.86027709585;12092;12203.14577979533;12227.082968777377;12234.755304893852;12237.20458170216;6725.327467253235;6736.764213252611;6817.761378351734;6854.143232095988;6866.244713081557;6585.9012114818315;6600.86798264032;6601.933980660228;6638.402543770987;6756.662166891636;3644.4351125575577;3791.2038471920655;3808.980955095207;3816;3861.6331448512346;1536.1013806923074;1629.128416297299;1630.152320793181;1656.3871367594068;1767.5757818123557;827.8096037911314;912.9041450647719;948.4451595816387;967.4582233949011;1031.6440827914357;16722.24749886258;17000.234989425506;17479.737803932952;17559.648807024045;17747.11264436773;902.6434558349415;904.1681652879366;905.2034209895381;917.6512925088424;919.2278486071732;9536.046395360547;9732.610695572097;9812.95093524542;9825.459599722084;9969.651062212934;398167;405771;419176;420139;424996;48101.75949120232;49650.75174624176;57959.13061304084;63742.6812865942;82364;934.8364036293622;948.6679662118204;969.5346233807812;972.2270794718216;974.4786539201351;15609.765853511979;15745.763813542577;15782.526524204291;15790.526284211033;16247.918760406123;35538.46692299669;35653;36385.63614363822;36596.63403366039;37028.629713703594;47679.76160119177;49420.75289623529;49852;49909.75045124751;50154;7407.1852096268285;7670.386369090348;7783.92216077832;7831.96084019599;7866.52800831929;11535.711607209887;11821.231619944676;11905.761884762429;11909.702257443632;11961.282323060645;10122.949385253027;10317.329373590692;10527.105196058421;10542.841857371992;10782.460876955964;10137.341072830242;10326.432046237529;10579.312344697877;10604.098651614699;10697.411642359744;10409.219308551737;10773.299735517166;10871.67384978452;10891.18316126278;10892.509837057192;7482.625868706434;7494.475386722877;7628.809279767828;7684.8463030740195;7836.451448398558;8787.91212087871;10242.436665983443;10389.168866490814;10567.260291779501;10627.787444251226 04:08:32 INFO - PROCESS | 3400 | |3;mootools.html;1241.6957845327884;1443.6751730860558;1474.307075674433;1631.8612917901978;1787.973180402295;6437.485001199904;7139.321764432384;7371.557706537598;7376.963115184423;7566.432517561191;7303.7078516859265;7462.104547454313;7477.2896574825445;7477.551346919188;7484.5135066220655;2175.923842665503;2200.207925146946;2208.0505382685437;2210.6352451845505;2210.690503329535;2138.561594873055;2170.066871245364;2192.232718548511;2201.636729939566;2203.922862699806;2130.5312831177116;2142.7750086240953;2151.6880052392394;2157.838162137838;2173.739151301838;2081.1155259014936;2082.7607573493747;2087.6242276390244;2087.7285952826187;2092.204962114402;2056.7531896172554;2091.7908209179113;2096.2558291806495;2097.024883429213;2100.0759665747023;7115.644217789141;7311.232320606313;7398.371138453238;7476.5514069156025;7478.887816682754;4333.826646934119;4464;4474.261746811772;4498.955010449887;4528.728276303399;2913.388188480422;2993.925151871199;3000.0999700089887;3011.292346298618;3041.893533726331;914.8124634449922;934.7195841247599;939.0797018921495;950.078423928788;967.1827305926481;9635.951820240924;9684;9714.31999760017;9737.65918192867;9748;3875.903102422462;3981.581933896899;3990.182012687392;4090.5295890972325;4097.282975479279;7678.424118191158;7693.538387696756;7708.691652333844;7718.343940764986;7746.341560967268;4462.732236065846;4474.731516109044;4493.640508759291;4494.685372023927;4495.842645507391;3584.2652256287397;3930.6855451563806;4098.1189044355015;4153.875383738493;4213.094184750294;3382.5602671652528;3398.8810391636175;3458.2219000724635;3478.5999610044664;3480.704140148065;1012.1801340913884;1025.8563801067855;1030.8711411073616;1037.6731329631143;1047.0681093826502;790.7864876483433;851.6125163050797;861.9008813986346;874.07784787049;882.770479675289;5041.495850414929;5126.5898728101665;5198.116320225571;5237.502437268454;5486.972565137149;904.7331037344;905.8822353094056;938.2165891480554;979.7648564344648;984.0995489127512;3415.692587667122;3606.909827254287;3608.6030536640947;3609.0796846803896;3631.364511210528;8409.915900841035;8783.297336213087;8941.731748047569;8959.865602015974;8967.730968070839;8530.14698530142;8900.510471924106;8910.688125915562;8926.107389261151;8927.821443571092;6908.032875397448;6993.860122797516;7009.193942696553;7030.472714546429;7038.049863268393;4823.421189457287;4924.384451943507;4982.227754698028;4990.8253211137435;5078.136716758087;8428.536430496382;8476.618552165044;8523.403361764866;8564.400491965753;8587.91412085896;8078.798030049295;8404.705835295736;8405.285550728013;8648.394612377326;8667.479951202948;5836.795712150054;6274.905876411766;6447.9355206447335;6540.345965403421;6660.1341825564305;7173.24680908518;7182.138143422822;7234.421246300389;7240.1311842579225;7257.2742725727;6408.359164083555;6555.082288479522;6584.736610535525;6679.465642748665;6701.1623547056615;6414.647194404352;6525.184351956005;6535.705893234911;6554;6572.079908812866;6191.25704915413;6340.49276057905;6370.522210834113;6381.904271435839;6398.936010639834;4377.759223242625;4414.823407063682;4433.778311084498;4551.34005569184;4634.23535116702;4362.323839804835;4408.58118478744;4457.710248833815;4514.661400394918;4533.637309015205 04:08:32 INFO - PROCESS | 3400 | |4;prototype.html;293.47907464250954;295.649655158637;300.8180051069102;304.62531086763295;305.2201624848514;4824.807007719692;4880.609551235902;4897.167481528144;4898.118338699032;4958.305837182797;4802.519748025195;4804.270462633449;4805.687630304036;4832.568876097975;4836.63725220609;3579.764981081523;3688.317661232667;3703.9814800925956;3810.932938777147;3833.2716783811125;3780.9432858507143;3789.3179227738997;3808.7333886627807;3815.5993620669847;3821.426785982097;3572.4462708280257;3766.7551609145453;3771.113788259757;3773.735838491307;3776.244751049801;3701.68535674468;3807.505024346845;3811.161544460228;3813.9618603813883;3817.7327587068917;3337.048941051813;3339.833008349573;3349.614794298638;3352.9832350838333;3354.3459025490038;4605.769711514445;4624.352590637313;4624.838130665411;4628.768561571942;4635.778134196735;4224.514180869178;4338.349247612852;4377.146456440995;4379.408779814716;4384.188925048876;5104.285400043997;5118.692878427306;5121.052605268037;5134.614903882224;5137.229415587654;3685.355062863988;3686.3733165361955;3704.629537046301;3707.8146092695256;3708.5364329458816;4987.501249874984;5325.627206095575;5330.333708286465;5336.546393556552;5344.6258761887075;3631.8547258109907;3641.4901913732097;3643.3259846928404;3648.0332711831384;3662.3957047087465;3686.5207523021836;3694.261147770403;3703.7407381483577;3703.814809259526;3710.0910276982313;4263.658907287409;4267.850625228102;4270.679699022586;4275.8075886585175;4277.230098582223;4864.878378040577;5071.721055341918;5130.538251557377;5131.307273518102;5131.692098474104;1219.439058033297;1232.3345393487596;1237.9195352302072;1240.8697086805937;1241.1994263699862;790.8256239484361;815.2092470303915;832.4630613254417;840.684743221292;842.3934766967774;4254.787260637017;4275.957240427618;4276.5295817460055;4302.763348015889;4334.674899382559;5034.144195486776;5043.621728370387;5049.899002020013;5056.898862022739;5069.631199576168;4177.206330797138;4228.4080228768;4253.680973926967;4279.807408666617;4318.697691161651;2714.7692446141905;2727.4954133485367;2729.863506824651;2734.220747087071;2741.2050505353222;4762.571368576775;4834.468208497063;4836.863337115775;4859.343988561499;4876.878078048077;4970.850874473772;5197.038547868581;5230.63385563007;5265.552428043659;5312.203169524525;4796.160671882407;4819.855404337875;4875.268709693503;4907.877303067452;4909.459959404534;5162.251473536391;5190.247414124855;5192.45479224676;5204.765785539736;5212.713300768494;4913.385826771653;5026.3214466048075;5033.899322013466;5096.108181068373;5109.437961824271;4789.281607758725;4809.062232864558;4816.446108697544;4842.789302674331;4871.5128487152415;3542.4863394808126;3553.857845686247;3569.303985722759;3579.302036102935;3589.4795254688447;4971.552560269593;5082.103201175295;5096.617753668415;5101.795928162832;5102.43873173958;4958.206686930074;4972.801087956441;4982.4768399317545;4988.079589358051;5006.997201119581;4963.503649635008;4986.900261994667;4987.526185012418;4990.500949905126;4998.975005124951;4691.5308469152815;4931.545194167657;4940.827071052496;4958.801647934187;4974.701517908937;4939.110960027229;4945.703257804544;5080.552042667822;5101.7194054327365;5101.724568857786;5000.224965130411;5011.674241174312;5017.724025178651;5018.949810501848;5031.4213865405945 04:08:32 INFO - PROCESS | 3400 | |5;yui.html;711.6164427128887;797.2266901105927;804.8148925747082;817.4645607127334;830.0371568979981;11398;11963.58127465539;12121.393930303493;12121.999999999989;12135.39323033847;12296.63110106696;12683.04877134214;12708.618741437771;12737.554185603505;12753.744925101493;669.5748199893054;843.8565443874556;869.2437579305997;883.4434306386967;883.5449743382163;887.2369762004671;888.5290795878195;889.4129874282942;889.8264838356523;890.5680744838749;922.8754118194058;925.2875286029753;925.4077390470104;925.6019911438079;925.7037747920668;699.545295557889;717.4905816870029;718.4324383736841;888.9466632002036;918.5682729117337;678.4097834883634;683.5761827666829;683.7504310926525;684.1174884399119;684.1960696181966;13077.869221307761;13107;13112.409941552558;13112.86887131126;13127.803082953764;12574.308413037279;12833.101682882108;13100.868991310155;13330.467211229932;13400.865991340059;11161.888381116167;11399.772004559945;11450.713732156679;11539.134564907581;11906;3614.331348700499;3679.0802299425145;3683.5027271318295;3756.5679946806194;3773.1699026214187;44699.77650111729;44731.776341118086;44791.10417791658;45003.77498112489;46611.76694116541;10255.846162307571;10322.535485903152;10473.31923424975;10540.789184216426;10690.73273168177;18129.54676133081;18190.45428637143;18294.90852545729;18406;18477.90761046186;6685.030670552743;6717.361850624183;6727.764528241488;6834.2482326944;7103.431725462054;3645.3073915955883;3651.94522082169;3702.629737026276;3723.9627603724157;3725.2363265530503;2850.4014157027254;2944.160914139503;2944.528875379929;2944.8085874418093;2946.882124714987;501.6939666803247;510.6340786277314;516.1998901702347;518.0623072239259;522.1019845865181;478.0439121756487;513.371120377542;556.1657513729406;562.2999365789618;580.3731969472959;7115.71537138519;7196;7381.224971378036;7382.704691812375;7484.438667099989;465.12324268753645;531.8856445864158;549.5905550365004;555.4279092534696;568.855884878657;3154.2114471382156;3283.441814891474;3391.9152021199666;3487.89536313911;3521;50737.49262507402;52428.737856311236;52730;52731.736341318814;53489.46510534923;48345.27482087771;48758.51241487611;48944;48988.51011489911;49743.25385119226;44443.555564443945;44621.77689111599;44755.77622111934;45041.32438013433;45514.77242613832;6840.48696347766;6899.6205208714;6918.792436226921;7008.334208250208;7038.225795162426;26310.342241444116;29360.55959160657;29826.701732982394;30126.397472050874;30492;35142.47286290759;36087.819560902026;36262;36628;36740.26519469649;9243.306751993492;10681.946590266998;10703.411312377893;10889.727756806144;10890.183236257153;9989.300748947504;10114.29199955996;10190.949045254727;10287.25583254228;10381.377117372982;9387.906120938977;9592.424454532751;9623.133917947418;9778.16885564735;9919.454430006419;9741.80516389654;10012.799744005224;11035.11719062457;11306.321620702454;12245.204061735958;10187.541560629938;10724.839127413252;10794;10861.619843305447;10896.237263391486;8969.551522423722;8975.910240897507;9004.819903602021;9285.767855803659;9376.953115234654;8339.708110216114;8451.915480845113;9505.382150160218;9630.807383852423;9652.806943861224 04:08:32 INFO - PROCESS | 3400 | __end_tp_report 04:08:32 INFO - PROCESS | 3400 | __start_cc_report 04:08:32 INFO - PROCESS | 3400 | _x_x_mozilla_cycle_collect,891 04:08:32 INFO - PROCESS | 3400 | __end_cc_report 04:08:32 INFO - PROCESS | 3400 | __startTimestamp1462792112970__endTimestamp 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | ------- Summary: start ------- 04:08:32 INFO - PROCESS | 3400 | Number of tests: 6 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#0] dojo.html Cycles:165 Average:4690.35 Median:4833.23 stddev:484.51 (10.0%) stddev-sans-first:459.52 04:08:32 INFO - PROCESS | 3400 | Values: 2676.6 2692.5 2721.5 2723.9 2740.1 4576.7 4644.3 4703.1 4797.6 4822.5 4664.4 4679.6 4694.5 4746.1 4806.6 4318.2 4331.2 4374.8 4401.7 4403.3 4347.8 4459.2 4499.6 4516.3 4539.6 4425.4 4430.8 4467.5 4481.2 4538.8 4201.7 4251.0 4267.1 4313.9 4321.3 4273.6 4273.9 4295.1 4299.1 4305.6 4555.0 4578.9 4644.6 4649.4 4654.6 5082.2 5088.4 5130.9 5136.6 5141.9 4893.8 5093.7 5112.7 5156.0 5170.4 4833.2 4837.0 4837.1 4875.8 4881.7 5274.9 5275.8 5278.2 5318.1 5321.5 4875.1 4920.7 4964.9 4980.5 5036.0 5022.5 5042.1 5049.8 5061.0 5099.9 4886.4 4998.3 5009.9 5022.2 5024.7 4906.1 5006.8 5056.1 5066.1 5100.3 4380.9 4385.7 4386.4 4387.2 4428.6 3813.2 3836.5 3849.6 3853.3 3866.8 4207.1 4211.5 4240.8 4277.6 4292.0 5031.1 5042.8 5060.2 5062.3 5107.3 4300.0 4302.1 4302.2 4302.5 4348.7 4479.4 4545.1 4569.0 4585.2 4590.4 4753.9 4765.4 4770.6 4779.9 4821.9 4973.0 5031.6 5064.4 5073.1 5120.7 4762.7 4799.6 4820.4 4823.1 4842.2 5026.3 5049.2 5056.0 5056.3 5112.9 4841.5 5066.8 5090.8 5104.6 5176.6 4939.1 4980.8 5001.6 5002.0 5056.2 4976.8 4987.1 4990.8 4994.0 5046.5 4698.5 4768.0 4794.5 4934.2 5001.1 4901.2 4913.5 4927.6 4932.5 4963.5 4835.8 4837.0 4841.7 4882.1 4892.9 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#1] ext.html Cycles:180 Average:45626.16 Median:36157.96 stddev:78576.74 (217.3%) stddev-sans-first:78724.38 04:08:32 INFO - PROCESS | 3400 | Values: 581.1 602.2 602.7 610.6 622.3 27188.9 30312.7 30347.2 43950.8 44703.8 43653.6 43760.3 43927.6 44105.6 44154.3 7360.8 7806.1 7955.4 7960.3 7965.9 7405.5 7662.2 7665.6 10081.1 10360.7 10237.5 10306.1 10316.7 10317.3 10323.0 10213.2 10293.5 10294.1 10297.1 10297.9 7497.3 7732.4 7735.7 9788.2 10214.7 39588.6 39980.4 40054.8 40073.8 40127.4 3223.1 3284.1 3316.7 3433.4 3522.3 29521.6 29873.7 30281.1 30515.5 30624.0 3119.3 3219.2 3223.2 3288.0 3315.1 178027.0 178371.0 178777.0 178933.0 180076.0 56973.7 57271.4 57289.7 57336.4 57339.1 35659.5 36656.5 36720.3 38711.0 38728.2 14805.8 14955.4 15015.4 15024.4 15031.3 9044.5 11146.3 11290.6 11290.8 11294.2 19331.0 20892.9 20928.3 20995.5 21008.7 7144.8 7275.2 7356.4 7381.2 7406.3 909.9 928.5 966.3 967.0 995.7 28299.4 29296.6 29371.3 29416.9 29727.6 1035.0 1039.3 1049.6 1050.6 1105.6 15397.9 15657.6 15711.4 15725.5 16142.5 385800.0 388109.0 388613.0 389822.0 391095.0 51678.7 52215.2 52343.2 52543.7 52546.7 1152.2 1271.4 1284.1 1288.6 1291.9 28515.3 29254.7 29763.7 30363.0 30379.2 44520.6 45060.8 45084.5 45098.3 45098.3 289611.0 290783.0 291310.0 291386.0 292278.0 22814.5 26156.2 27046.9 27209.3 28368.1 42509.0 43353.0 43601.6 43999.3 44449.8 37161.8 37303.6 37668.2 37823.6 38198.6 36681.9 37050.6 37479.3 37533.8 37654.2 36804.4 41310.0 42008.4 42906.8 46119.0 36927.5 40692.0 41165.8 41455.4 41490.8 30609.5 31399.2 31441.2 31468.2 32205.2 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#2] jquery.html Cycles:180 Average:24251.70 Median:422567.50 stddev:67906.50 (16.1%) stddev-sans-first:68073.29 04:08:32 INFO - PROCESS | 3400 | Values: 356.3 357.4 358.1 374.4 378.2 16179.0 17654.7 17703.9 18051.5 18183.6 17207.0 17230.7 17476.0 17929.3 17934.8 5053.9 5171.3 5236.3 5254.4 5262.2 3692.2 5040.8 5208.8 6071.4 6073.7 5997.6 6101.1 6116.8 6128.5 6129.2 5964.2 6058.6 6100.9 6180.4 6191.0 5242.8 5244.3 5245.0 5250.7 5250.7 11120.6 11622.9 11632.7 11957.8 11962.8 2056.6 2060.9 2145.7 2394.7 2517.7 9144.5 9545.8 9571.6 9999.8 13032.9 1773.1 1804.8 1830.6 1872.6 1875.5 62895.7 69970.3 70490.0 70588.3 71670.0 9129.5 9175.5 9190.4 9200.7 9314.9 12092.0 12203.1 12227.1 12234.8 12237.2 6725.3 6736.8 6817.8 6854.1 6866.2 6585.9 6600.9 6601.9 6638.4 6756.7 3644.4 3791.2 3809.0 3816.0 3861.6 1536.1 1629.1 1630.2 1656.4 1767.6 827.8 912.9 948.4 967.5 1031.6 16722.2 17000.2 17479.7 17559.6 17747.1 902.6 904.2 905.2 917.7 919.2 9536.0 9732.6 9813.0 9825.5 9969.7 398167.0 405771.0 419176.0 420139.0 424996.0 48101.8 49650.8 57959.1 63742.7 82364.0 934.8 948.7 969.5 972.2 974.5 15609.8 15745.8 15782.5 15790.5 16247.9 35538.5 35653.0 36385.6 36596.6 37028.6 47679.8 49420.8 49852.0 49909.8 50154.0 7407.2 7670.4 7783.9 7832.0 7866.5 11535.7 11821.2 11905.8 11909.7 11961.3 10122.9 10317.3 10527.1 10542.8 10782.5 10137.3 10326.4 10579.3 10604.1 10697.4 10409.2 10773.3 10871.7 10891.2 10892.5 7482.6 7494.5 7628.8 7684.8 7836.5 8787.9 10242.4 10389.2 10567.3 10627.8 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#3] mootools.html Cycles:180 Average:4890.71 Median:6014.03 stddev:2627.89 (43.7%) stddev-sans-first:2620.95 04:08:32 INFO - PROCESS | 3400 | Values: 1241.7 1443.7 1474.3 1631.9 1788.0 6437.5 7139.3 7371.6 7377.0 7566.4 7303.7 7462.1 7477.3 7477.6 7484.5 2175.9 2200.2 2208.1 2210.6 2210.7 2138.6 2170.1 2192.2 2201.6 2203.9 2130.5 2142.8 2151.7 2157.8 2173.7 2081.1 2082.8 2087.6 2087.7 2092.2 2056.8 2091.8 2096.3 2097.0 2100.1 7115.6 7311.2 7398.4 7476.6 7478.9 4333.8 4464.0 4474.3 4499.0 4528.7 2913.4 2993.9 3000.1 3011.3 3041.9 914.8 934.7 939.1 950.1 967.2 9636.0 9684.0 9714.3 9737.7 9748.0 3875.9 3981.6 3990.2 4090.5 4097.3 7678.4 7693.5 7708.7 7718.3 7746.3 4462.7 4474.7 4493.6 4494.7 4495.8 3584.3 3930.7 4098.1 4153.9 4213.1 3382.6 3398.9 3458.2 3478.6 3480.7 1012.2 1025.9 1030.9 1037.7 1047.1 790.8 851.6 861.9 874.1 882.8 5041.5 5126.6 5198.1 5237.5 5487.0 904.7 905.9 938.2 979.8 984.1 3415.7 3606.9 3608.6 3609.1 3631.4 8409.9 8783.3 8941.7 8959.9 8967.7 8530.1 8900.5 8910.7 8926.1 8927.8 6908.0 6993.9 7009.2 7030.5 7038.0 4823.4 4924.4 4982.2 4990.8 5078.1 8428.5 8476.6 8523.4 8564.4 8587.9 8078.8 8404.7 8405.3 8648.4 8667.5 5836.8 6274.9 6447.9 6540.3 6660.1 7173.2 7182.1 7234.4 7240.1 7257.3 6408.4 6555.1 6584.7 6679.5 6701.2 6414.6 6525.2 6535.7 6554.0 6572.1 6191.3 6340.5 6370.5 6381.9 6398.9 4377.8 4414.8 4433.8 4551.3 4634.2 4362.3 4408.6 4457.7 4514.7 4533.6 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#4] prototype.html Cycles:180 Average:4167.11 Median:4804.98 stddev:1212.26 (25.2%) stddev-sans-first:1180.28 04:08:32 INFO - PROCESS | 3400 | Values: 293.5 295.6 300.8 304.6 305.2 4824.8 4880.6 4897.2 4898.1 4958.3 4802.5 4804.3 4805.7 4832.6 4836.6 3579.8 3688.3 3704.0 3810.9 3833.3 3780.9 3789.3 3808.7 3815.6 3821.4 3572.4 3766.8 3771.1 3773.7 3776.2 3701.7 3807.5 3811.2 3814.0 3817.7 3337.0 3339.8 3349.6 3353.0 3354.3 4605.8 4624.4 4624.8 4628.8 4635.8 4224.5 4338.3 4377.1 4379.4 4384.2 5104.3 5118.7 5121.1 5134.6 5137.2 3685.4 3686.4 3704.6 3707.8 3708.5 4987.5 5325.6 5330.3 5336.5 5344.6 3631.9 3641.5 3643.3 3648.0 3662.4 3686.5 3694.3 3703.7 3703.8 3710.1 4263.7 4267.9 4270.7 4275.8 4277.2 4864.9 5071.7 5130.5 5131.3 5131.7 1219.4 1232.3 1237.9 1240.9 1241.2 790.8 815.2 832.5 840.7 842.4 4254.8 4276.0 4276.5 4302.8 4334.7 5034.1 5043.6 5049.9 5056.9 5069.6 4177.2 4228.4 4253.7 4279.8 4318.7 2714.8 2727.5 2729.9 2734.2 2741.2 4762.6 4834.5 4836.9 4859.3 4876.9 4970.9 5197.0 5230.6 5265.6 5312.2 4796.2 4819.9 4875.3 4907.9 4909.5 5162.3 5190.2 5192.5 5204.8 5212.7 4913.4 5026.3 5033.9 5096.1 5109.4 4789.3 4809.1 4816.4 4842.8 4871.5 3542.5 3553.9 3569.3 3579.3 3589.5 4971.6 5082.1 5096.6 5101.8 5102.4 4958.2 4972.8 4982.5 4988.1 5007.0 4963.5 4986.9 4987.5 4990.5 4999.0 4691.5 4931.5 4940.8 4958.8 4974.7 4939.1 4945.7 5080.6 5101.7 5101.7 5000.2 5011.7 5017.7 5018.9 5031.4 04:08:32 INFO - PROCESS | 3400 | 04:08:32 INFO - PROCESS | 3400 | [#5] yui.html Cycles:180 Average:12755.14 Median:22989.95 stddev:14606.06 (63.5%) stddev-sans-first:14619.04 04:08:32 INFO - PROCESS | 3400 | Values: 711.6 797.2 804.8 817.5 830.0 11398.0 11963.6 12121.4 12122.0 12135.4 12296.6 12683.0 12708.6 12737.6 12753.7 669.6 843.9 869.2 883.4 883.5 887.2 888.5 889.4 889.8 890.6 922.9 925.3 925.4 925.6 925.7 699.5 717.5 718.4 888.9 918.6 678.4 683.6 683.8 684.1 684.2 13077.9 13107.0 13112.4 13112.9 13127.8 12574.3 12833.1 13100.9 13330.5 13400.9 11161.9 11399.8 11450.7 11539.1 11906.0 3614.3 3679.1 3683.5 3756.6 3773.2 44699.8 44731.8 44791.1 45003.8 46611.8 10255.8 10322.5 10473.3 10540.8 10690.7 18129.5 18190.5 18294.9 18406.0 18477.9 6685.0 6717.4 6727.8 6834.2 7103.4 3645.3 3651.9 3702.6 3724.0 3725.2 2850.4 2944.2 2944.5 2944.8 2946.9 501.7 510.6 516.2 518.1 522.1 478.0 513.4 556.2 562.3 580.4 7115.7 7196.0 7381.2 7382.7 7484.4 465.1 531.9 549.6 555.4 568.9 3154.2 3283.4 3391.9 3487.9 3521.0 50737.5 52428.7 52730.0 52731.7 53489.5 48345.3 48758.5 48944.0 48988.5 49743.3 44443.6 44621.8 44755.8 45041.3 45514.8 6840.5 6899.6 6918.8 7008.3 7038.2 26310.3 29360.6 29826.7 30126.4 30492.0 35142.5 36087.8 36262.0 36628.0 36740.3 9243.3 10681.9 10703.4 10889.7 10890.2 9989.3 10114.3 10190.9 10287.3 10381.4 9387.9 9592.4 9623.1 9778.2 9919.5 9741.8 10012.8 11035.1 11306.3 12245.2 10187.5 10724.8 10794.0 10861.6 10896.2 8969.6 8975.9 9004.8 9285.8 9377.0 8339.7 8451.9 9505.4 9630.8 9652.8 04:08:32 INFO - PROCESS | 3400 | -------- Summary: end -------- 04:08:32 INFO - PROCESS | 3400 | 04:08:33 INFO - TEST-INFO | 3400: exit 0 04:08:33 INFO - TEST-OK | dromaeo_css | took 1120708ms 04:08:33 INFO - TEST-START | kraken 04:08:33 INFO - operating with platform_type : linux_ 04:08:33 INFO - Initialising browser for kraken test... 04:08:33 INFO - TEST-INFO | started process 3615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJThZIM/profile http://localhost:60784/getInfo.html) 04:08:38 INFO - PROCESS | 3615 | __metrics Screen width/height:1600/1200 04:08:38 INFO - PROCESS | 3615 | colorDepth:24 04:08:38 INFO - PROCESS | 3615 | Browser inner width/height: 1024/697 04:08:38 INFO - PROCESS | 3615 | __metrics 04:08:39 ERROR - PROCESS | 3615 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:08:40 INFO - TEST-INFO | 3615: exit 0 04:08:40 INFO - Browser initialized. 04:08:40 INFO - Running cycle 1/1 for kraken test... 04:08:40 INFO - TEST-INFO | started process 3695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJThZIM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:52 INFO - PROCESS | 3695 | RSS: Main: 153755648 04:08:52 INFO - PROCESS | 3695 | 04:08:54 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60784/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:55 INFO - PROCESS | 3695 | RSS: Main: 209362944 04:08:55 INFO - PROCESS | 3695 | 04:08:58 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60784/tests/kraken/driver.html?testName=audio-dft) 04:08:59 INFO - PROCESS | 3695 | RSS: Main: 196767744 04:08:59 INFO - PROCESS | 3695 | 04:09:02 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60784/tests/kraken/driver.html?testName=audio-fft) 04:09:03 INFO - PROCESS | 3695 | RSS: Main: 266330112 04:09:03 INFO - PROCESS | 3695 | 04:09:05 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60784/tests/kraken/driver.html?testName=audio-oscillator) 04:09:05 INFO - PROCESS | 3695 | RSS: Main: 175366144 04:09:05 INFO - PROCESS | 3695 | 04:09:08 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:08 INFO - PROCESS | 3695 | RSS: Main: 178835456 04:09:08 INFO - PROCESS | 3695 | 04:09:12 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60784/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:12 INFO - PROCESS | 3695 | RSS: Main: 215257088 04:09:12 INFO - PROCESS | 3695 | 04:09:16 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60784/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:17 INFO - PROCESS | 3695 | RSS: Main: 213876736 04:09:17 INFO - PROCESS | 3695 | 04:09:20 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60784/tests/kraken/driver.html?testName=json-parse-financial) 04:09:20 INFO - PROCESS | 3695 | RSS: Main: 213741568 04:09:20 INFO - PROCESS | 3695 | 04:09:22 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:23 INFO - PROCESS | 3695 | RSS: Main: 208965632 04:09:23 INFO - PROCESS | 3695 | 04:09:25 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:25 INFO - PROCESS | 3695 | RSS: Main: 210006016 04:09:25 INFO - PROCESS | 3695 | 04:09:28 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:28 INFO - PROCESS | 3695 | RSS: Main: 212643840 04:09:28 INFO - PROCESS | 3695 | 04:09:31 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:32 INFO - PROCESS | 3695 | RSS: Main: 216535040 04:09:32 INFO - PROCESS | 3695 | 04:09:35 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:36 INFO - PROCESS | 3695 | RSS: Main: 216240128 04:09:36 INFO - PROCESS | 3695 | 04:09:37 INFO - PROCESS | 3695 | Cycle 1(1): loaded http://localhost:60784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60784/tests/kraken/driver.html?testName=ai-astar) 04:09:38 INFO - PROCESS | 3695 | RSS: Main: 262520832 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | __start_tp_report 04:09:38 INFO - PROCESS | 3695 | _x_x_mozilla_page_load 04:09:38 INFO - PROCESS | 3695 | _x_x_mozilla_page_load_details 04:09:38 INFO - PROCESS | 3695 | |i|pagename|runs| 04:09:38 INFO - PROCESS | 3695 | |0;ai-astar;116;112;116;113;114;115;114;113;113;114 04:09:38 INFO - PROCESS | 3695 | |1;audio-beat-detection;153;136;158;218;130;155;158;131;187;129 04:09:38 INFO - PROCESS | 3695 | |2;audio-dft;161;161;160;160;160;161;161;161;163;160 04:09:38 INFO - PROCESS | 3695 | |3;audio-fft;76;77;77;146;75;74;77;76;137;77 04:09:38 INFO - PROCESS | 3695 | |4;audio-oscillator;93;93;148;92;93;93;124;93;92;126 04:09:38 INFO - PROCESS | 3695 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;117 04:09:38 INFO - PROCESS | 3695 | |6;imaging-darkroom;146;147;146;146;147;147;147;146;147;146 04:09:38 INFO - PROCESS | 3695 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;96;94 04:09:38 INFO - PROCESS | 3695 | |8;json-parse-financial;65;66;64;64;64;65;69;65;65;65 04:09:38 INFO - PROCESS | 3695 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;64;64 04:09:38 INFO - PROCESS | 3695 | |10;stanford-crypto-aes;89;82;83;82;87;84;85;83;159;83 04:09:38 INFO - PROCESS | 3695 | |11;stanford-crypto-ccm;131;140;141;131;129;129;135;132;158;135 04:09:38 INFO - PROCESS | 3695 | |12;stanford-crypto-pbkdf2;174;180;174;174;172;171;169;172;168;169 04:09:38 INFO - PROCESS | 3695 | |13;stanford-crypto-sha256-iterative;68;69;68;69;67;67;70;69;67;67 04:09:38 INFO - PROCESS | 3695 | __end_tp_report 04:09:38 INFO - PROCESS | 3695 | __start_cc_report 04:09:38 INFO - PROCESS | 3695 | _x_x_mozilla_cycle_collect,2093 04:09:38 INFO - PROCESS | 3695 | __end_cc_report 04:09:38 INFO - PROCESS | 3695 | __startTimestamp1462792178193__endTimestamp 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | ------- Summary: start ------- 04:09:38 INFO - PROCESS | 3695 | Number of tests: 14 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.33 (1.2%) stddev-sans-first:1.20 04:09:38 INFO - PROCESS | 3695 | Values: 116.0 112.0 116.0 113.0 114.0 115.0 114.0 113.0 113.0 114.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:156.50 stddev:28.38 (18.1%) stddev-sans-first:30.09 04:09:38 INFO - PROCESS | 3695 | Values: 153.0 136.0 158.0 218.0 130.0 155.0 158.0 131.0 187.0 129.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 04:09:38 INFO - PROCESS | 3695 | Values: 161.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 163.0 160.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#3] audio-fft Cycles:10 Average:89.20 Median:76.50 stddev:27.66 (36.2%) stddev-sans-first:28.93 04:09:38 INFO - PROCESS | 3695 | Values: 76.0 77.0 77.0 146.0 75.0 74.0 77.0 76.0 137.0 77.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:93.00 stddev:20.30 (21.8%) stddev-sans-first:21.08 04:09:38 INFO - PROCESS | 3695 | Values: 93.0 93.0 148.0 92.0 93.0 93.0 124.0 93.0 92.0 126.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:09:38 INFO - PROCESS | 3695 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:09:38 INFO - PROCESS | 3695 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:09:38 INFO - PROCESS | 3695 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 04:09:38 INFO - PROCESS | 3695 | Values: 65.0 66.0 64.0 64.0 64.0 65.0 69.0 65.0 65.0 65.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:09:38 INFO - PROCESS | 3695 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:83.50 stddev:23.75 (28.4%) stddev-sans-first:25.17 04:09:38 INFO - PROCESS | 3695 | Values: 89.0 82.0 83.0 82.0 87.0 84.0 85.0 83.0 159.0 83.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.00 stddev:8.76 (6.5%) stddev-sans-first:9.10 04:09:38 INFO - PROCESS | 3695 | Values: 131.0 140.0 141.0 131.0 129.0 129.0 135.0 132.0 158.0 135.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.50 (2.0%) stddev-sans-first:3.66 04:09:38 INFO - PROCESS | 3695 | Values: 174.0 180.0 174.0 174.0 172.0 171.0 169.0 172.0 168.0 169.0 04:09:38 INFO - PROCESS | 3695 | 04:09:38 INFO - PROCESS | 3695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.10 (1.6%) stddev-sans-first:1.17 04:09:38 INFO - PROCESS | 3695 | Values: 68.0 69.0 68.0 69.0 67.0 67.0 70.0 69.0 67.0 67.0 04:09:38 INFO - PROCESS | 3695 | -------- Summary: end -------- 04:09:38 INFO - PROCESS | 3695 | 04:09:39 INFO - TEST-INFO | 3695: exit 0 04:09:39 INFO - TEST-OK | kraken | took 66159ms 04:09:39 INFO - SUITE-END | took 1186s 04:09:40 INFO - Completed test suite (00:19:47) 04:09:40 INFO - javascript benchmark 04:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.5717485202367, 2692.488427198831, 2721.455708858228, 2723.8910443582263, 2740.1231605886123, 4576.7025143365745, 4644.349791029259, 4703.129920964624, 4797.616190704748, 4822.469528351883, 4664.3936288282475, 4679.555442232991, 4694.507076756942, 4746.098241334144, 4806.639502037352, 4318.157959197958, 4331.242032644291, 4374.759388233661, 4401.735895846244, 4403.273459879116, 4347.760873151976, 4459.15276097542, 4499.640028797705, 4516.345129956171, 4539.59143677069, 4425.424694789656, 4430.778461076933, 4467.463904331485, 4481.170983368087, 4538.7503687297185, 4201.663866890672, 4250.978745106255, 4267.0825772459075, 4313.935290970638, 4321.308590625485, 4273.551277115889, 4273.850415235483, 4295.076558539929, 4299.14017196562, 4305.5694430557005, 4555.020670555813, 4578.931316030262, 4644.58198762113, 4649.418822647169, 4654.604358629521, 5082.161443361841, 5088.4148322942965, 5130.871728206825, 5136.614753893473, 5141.948580514222, 4893.75531223441, 5093.694378337274, 5112.744362781883, 5155.9742201288755, 5170.431252562215, 4833.226683730586, 4837.0, 4837.105135549935, 4875.780589873464, 4881.731504767236, 5274.947250527523, 5275.815346462856, 5278.234655974862, 5318.12250978592, 5321.494458026481, 4875.07373599015, 4920.729359885169, 4964.851054468371, 4980.5019498049905, 5036.0179764946215, 5022.472640372781, 5042.067217564762, 5049.823256186016, 5061.0, 5099.9490005100215, 4886.413630364308, 4998.275250088789, 5009.949900500948, 5022.2466630005065, 5024.698518088926, 4906.092372911023, 5006.824761133343, 5056.115179843513, 5066.06277838601, 5100.260462232955, 4380.9123817524105, 4385.7149285296355, 4386.429764130707, 4387.232234359039, 4428.557144285545, 3813.237352529505, 3836.5396152461885, 3849.576546579874, 3853.2871418787613, 3866.845326186977, 4207.095474473003, 4211.494620645542, 4240.830366785356, 4277.636400905895, 4292.034292284211, 5031.069252188357, 5042.7982880685095, 5060.1903695408555, 5062.341895553628, 5107.310513080686, 4300.0, 4302.09655972243, 4302.204092242945, 4302.526722060571, 4348.7390756554705, 4479.417675702138, 4545.090981803586, 4568.954310456919, 4585.220512512881, 4590.449146102489, 4753.881152971203, 4765.404324459512, 4770.6183505318795, 4779.880502987453, 4821.855344339676, 4972.975135124301, 5031.572316353151, 5064.392272927125, 5073.137566613611, 5120.667156634807, 4762.666613337172, 4799.568038876518, 4820.373351464287, 4823.131836269506, 4842.176829938849, 5026.321446604661, 5049.23225571882, 5055.974720126376, 5056.292119103255, 5112.897742045064, 4841.515848415131, 5066.82266120684, 5090.821821236239, 5104.591632669451, 5176.637635365489, 4939.061578300111, 4980.750962451935, 5001.57486613642, 5001.974990125172, 5056.191009438472, 4976.825811096594, 4987.077390682735, 4990.8003679853855, 4994.02616489781, 5046.495350464924, 4698.506656800987, 4768.0, 4794.472608013186, 4934.18585933317, 5001.099802035668, 4901.240307752304, 4913.484084171254, 4927.581155601814, 4932.482089380707, 4963.478834722302, 4835.830745923876, 4837.032593481388, 4841.685290456109, 4882.145624515624, 4892.92660610084], "value": 4660.399845356183, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.0789898011651, 602.1750202222955, 602.7257597793005, 610.6214147228719, 622.2812651387646, 27188.864055679744, 30312.696873031262, 30347.241318967008, 43950.7802460988, 44703.77648111763, 43653.56346436535, 43760.343594846105, 43927.560724392744, 44105.55894441055, 44154.33768493467, 7360.779176624683, 7806.102298235691, 7955.363570914313, 7960.323372513343, 7965.8805117923275, 7405.518641288299, 7662.233776622349, 7665.616719164047, 10081.09270165685, 10360.740981475448, 10237.488125593727, 10306.072453479223, 10316.742081447986, 10317.277790554665, 10323.0, 10213.182945364353, 10293.485325733758, 10294.073533381994, 10297.07326340633, 10297.9485102574, 7497.250274972514, 7732.4200684948855, 7735.651895664709, 9788.21694264457, 10214.744631384201, 39588.60411395907, 39980.40029399561, 40054.799726001474, 40073.79963100166, 40127.39808902869, 3223.1136437479645, 3284.0640417480904, 3316.668333166688, 3433.4334834752235, 3522.348365552381, 29521.557176642367, 29873.70126298731, 30281.091567253017, 30515.542266866014, 30624.0, 3119.2825650100604, 3219.2273854274804, 3223.2425380035675, 3287.96712032879, 3315.1380641033265, 178027.0, 178371.0, 178777.0, 178933.0, 180076.0, 56973.71513142408, 57271.42728572744, 57289.713551431974, 57336.426635733944, 57339.13991290134, 35659.4651080234, 36656.45015324772, 36720.26559468795, 38711.0, 38728.225435491695, 14805.777913331309, 14955.40178392852, 15015.399384024735, 15024.399024039134, 15031.323590438456, 9044.547772611342, 11146.331220126818, 11290.604828831116, 11290.774184516264, 11294.152938529644, 19331.02015231451, 20892.85089320102, 20928.267510637055, 20995.47511312199, 21008.73947563151, 7144.821379465555, 7275.236100209508, 7356.448266380043, 7381.224971378036, 7406.296401841816, 909.9226565741853, 928.5310917986374, 966.2946049383849, 967.02330646048, 995.7311525888115, 28299.43401131966, 29296.56055159174, 29371.27168351429, 29416.852915735286, 29727.554086688717, 1034.9948250258851, 1039.3348257115451, 1049.5801679328329, 1050.558765318568, 1105.6240878101485, 15397.923010384877, 15657.608559786097, 15711.371545138296, 15725.528234152993, 16142.515724528283, 385800.0, 388109.0, 388613.0, 389822.0, 391095.0, 51678.741606291725, 52215.216771748455, 52343.21485177725, 52543.73728131411, 52546.73726631419, 1152.176194021279, 1271.3770252576355, 1284.1139613666726, 1288.6391810293132, 1291.8772716592098, 28515.28711782222, 29254.7074529252, 29763.70236297696, 30363.0, 30379.2405189872, 44520.554794451644, 45060.77469612631, 45084.54915450804, 45098.323525146494, 45098.3235251478, 289611.0, 290783.0, 291310.0, 291386.0, 292278.0, 22814.543709126057, 26156.215313540622, 27046.864765676044, 27209.31976700598, 28368.148955531367, 42509.0, 43353.0, 43601.56398436102, 43999.340009900516, 44449.77775111104, 37161.814190928875, 37303.626963730014, 37668.24663506769, 37823.62176378201, 38198.61801382062, 36681.862504887235, 37050.6294937058, 37479.25041499209, 37533.81233093817, 37654.2469150621, 36804.447933280484, 41310.0, 42008.369874451295, 42906.78546607247, 46119.0, 36927.54085610967, 40692.0, 41165.79417102895, 41455.37816932809, 41490.792546037075, 30609.54085688761, 31399.21501962469, 31441.21396965094, 31468.213294667818, 32205.194870128435], "value": 18290.57221920073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.29275887363576, 357.3888650407803, 358.0547354982845, 374.4271264964605, 378.1661436532446, 16179.0, 17654.73517897231, 17703.91148044258, 18051.458456246335, 18183.636327273463, 17207.0, 17230.655386892253, 17476.0, 17929.282828686835, 17934.820651793478, 5053.873653158673, 5171.327727395452, 5236.2931004314505, 5254.4220135785035, 5262.236975638531, 3692.1877187018813, 5040.7731652075745, 5208.791648334062, 6071.3625069367745, 6073.726682299307, 5997.61015533991, 6101.054336577816, 6116.7553297868035, 6128.479079278267, 6129.233845769279, 5964.1650168976375, 6058.636481811083, 6100.938990610081, 6180.351063138396, 6190.969045154768, 5242.842714718565, 5244.29202057725, 5245.0, 5250.684958902478, 5250.7112108834, 11120.61077862271, 11622.94188529052, 11632.651020469399, 11957.820632690517, 11962.82055769164, 2056.629806634805, 2060.8969551522364, 2145.6566949288194, 2394.736578976311, 2517.748225177486, 9144.45133291998, 9545.761355966088, 9571.617135314578, 9999.75000624983, 13032.934835325763, 1773.122304459288, 1804.7563578916809, 1830.6430246102016, 1872.6348362069402, 1875.5404925793268, 62895.68552157256, 69970.3002969969, 70490.0, 70588.29411705869, 71670.0, 9129.45223286605, 9175.54122293896, 9190.40262382943, 9200.6779762708, 9314.86027709585, 12092.0, 12203.14577979533, 12227.082968777377, 12234.755304893852, 12237.20458170216, 6725.327467253235, 6736.764213252611, 6817.761378351734, 6854.143232095988, 6866.244713081557, 6585.9012114818315, 6600.86798264032, 6601.933980660228, 6638.402543770987, 6756.662166891636, 3644.4351125575577, 3791.2038471920655, 3808.980955095207, 3816.0, 3861.6331448512346, 1536.1013806923074, 1629.128416297299, 1630.152320793181, 1656.3871367594068, 1767.5757818123557, 827.8096037911314, 912.9041450647719, 948.4451595816387, 967.4582233949011, 1031.6440827914357, 16722.24749886258, 17000.234989425506, 17479.737803932952, 17559.648807024045, 17747.11264436773, 902.6434558349415, 904.1681652879366, 905.2034209895381, 917.6512925088424, 919.2278486071732, 9536.046395360547, 9732.610695572097, 9812.95093524542, 9825.459599722084, 9969.651062212934, 398167.0, 405771.0, 419176.0, 420139.0, 424996.0, 48101.75949120232, 49650.75174624176, 57959.13061304084, 63742.6812865942, 82364.0, 934.8364036293622, 948.6679662118204, 969.5346233807812, 972.2270794718216, 974.4786539201351, 15609.765853511979, 15745.763813542577, 15782.526524204291, 15790.526284211033, 16247.918760406123, 35538.46692299669, 35653.0, 36385.63614363822, 36596.63403366039, 37028.629713703594, 47679.76160119177, 49420.75289623529, 49852.0, 49909.75045124751, 50154.0, 7407.1852096268285, 7670.386369090348, 7783.92216077832, 7831.96084019599, 7866.52800831929, 11535.711607209887, 11821.231619944676, 11905.761884762429, 11909.702257443632, 11961.282323060645, 10122.949385253027, 10317.329373590692, 10527.105196058421, 10542.841857371992, 10782.460876955964, 10137.341072830242, 10326.432046237529, 10579.312344697877, 10604.098651614699, 10697.411642359744, 10409.219308551737, 10773.299735517166, 10871.67384978452, 10891.18316126278, 10892.509837057192, 7482.625868706434, 7494.475386722877, 7628.809279767828, 7684.8463030740195, 7836.451448398558, 8787.91212087871, 10242.436665983443, 10389.168866490814, 10567.260291779501, 10627.787444251226], "value": 8105.1032369035875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.6957845327884, 1443.6751730860558, 1474.307075674433, 1631.8612917901978, 1787.973180402295, 6437.485001199904, 7139.321764432384, 7371.557706537598, 7376.963115184423, 7566.432517561191, 7303.7078516859265, 7462.104547454313, 7477.2896574825445, 7477.551346919188, 7484.5135066220655, 2175.923842665503, 2200.207925146946, 2208.0505382685437, 2210.6352451845505, 2210.690503329535, 2138.561594873055, 2170.066871245364, 2192.232718548511, 2201.636729939566, 2203.922862699806, 2130.5312831177116, 2142.7750086240953, 2151.6880052392394, 2157.838162137838, 2173.739151301838, 2081.1155259014936, 2082.7607573493747, 2087.6242276390244, 2087.7285952826187, 2092.204962114402, 2056.7531896172554, 2091.7908209179113, 2096.2558291806495, 2097.024883429213, 2100.0759665747023, 7115.644217789141, 7311.232320606313, 7398.371138453238, 7476.5514069156025, 7478.887816682754, 4333.826646934119, 4464.0, 4474.261746811772, 4498.955010449887, 4528.728276303399, 2913.388188480422, 2993.925151871199, 3000.0999700089887, 3011.292346298618, 3041.893533726331, 914.8124634449922, 934.7195841247599, 939.0797018921495, 950.078423928788, 967.1827305926481, 9635.951820240924, 9684.0, 9714.31999760017, 9737.65918192867, 9748.0, 3875.903102422462, 3981.581933896899, 3990.182012687392, 4090.5295890972325, 4097.282975479279, 7678.424118191158, 7693.538387696756, 7708.691652333844, 7718.343940764986, 7746.341560967268, 4462.732236065846, 4474.731516109044, 4493.640508759291, 4494.685372023927, 4495.842645507391, 3584.2652256287397, 3930.6855451563806, 4098.1189044355015, 4153.875383738493, 4213.094184750294, 3382.5602671652528, 3398.8810391636175, 3458.2219000724635, 3478.5999610044664, 3480.704140148065, 1012.1801340913884, 1025.8563801067855, 1030.8711411073616, 1037.6731329631143, 1047.0681093826502, 790.7864876483433, 851.6125163050797, 861.9008813986346, 874.07784787049, 882.770479675289, 5041.495850414929, 5126.5898728101665, 5198.116320225571, 5237.502437268454, 5486.972565137149, 904.7331037344, 905.8822353094056, 938.2165891480554, 979.7648564344648, 984.0995489127512, 3415.692587667122, 3606.909827254287, 3608.6030536640947, 3609.0796846803896, 3631.364511210528, 8409.915900841035, 8783.297336213087, 8941.731748047569, 8959.865602015974, 8967.730968070839, 8530.14698530142, 8900.510471924106, 8910.688125915562, 8926.107389261151, 8927.821443571092, 6908.032875397448, 6993.860122797516, 7009.193942696553, 7030.472714546429, 7038.049863268393, 4823.421189457287, 4924.384451943507, 4982.227754698028, 4990.8253211137435, 5078.136716758087, 8428.536430496382, 8476.618552165044, 8523.403361764866, 8564.400491965753, 8587.91412085896, 8078.798030049295, 8404.705835295736, 8405.285550728013, 8648.394612377326, 8667.479951202948, 5836.795712150054, 6274.905876411766, 6447.9355206447335, 6540.345965403421, 6660.1341825564305, 7173.24680908518, 7182.138143422822, 7234.421246300389, 7240.1311842579225, 7257.2742725727, 6408.359164083555, 6555.082288479522, 6584.736610535525, 6679.465642748665, 6701.1623547056615, 6414.647194404352, 6525.184351956005, 6535.705893234911, 6554.0, 6572.079908812866, 6191.25704915413, 6340.49276057905, 6370.522210834113, 6381.904271435839, 6398.936010639834, 4377.759223242625, 4414.823407063682, 4433.778311084498, 4551.34005569184, 4634.23535116702, 4362.323839804835, 4408.58118478744, 4457.710248833815, 4514.661400394918, 4533.637309015205], "value": 3998.604226878708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.47907464250954, 295.649655158637, 300.8180051069102, 304.62531086763295, 305.2201624848514, 4824.807007719692, 4880.609551235902, 4897.167481528144, 4898.118338699032, 4958.305837182797, 4802.519748025195, 4804.270462633449, 4805.687630304036, 4832.568876097975, 4836.63725220609, 3579.764981081523, 3688.317661232667, 3703.9814800925956, 3810.932938777147, 3833.2716783811125, 3780.9432858507143, 3789.3179227738997, 3808.7333886627807, 3815.5993620669847, 3821.426785982097, 3572.4462708280257, 3766.7551609145453, 3771.113788259757, 3773.735838491307, 3776.244751049801, 3701.68535674468, 3807.505024346845, 3811.161544460228, 3813.9618603813883, 3817.7327587068917, 3337.048941051813, 3339.833008349573, 3349.614794298638, 3352.9832350838333, 3354.3459025490038, 4605.769711514445, 4624.352590637313, 4624.838130665411, 4628.768561571942, 4635.778134196735, 4224.514180869178, 4338.349247612852, 4377.146456440995, 4379.408779814716, 4384.188925048876, 5104.285400043997, 5118.692878427306, 5121.052605268037, 5134.614903882224, 5137.229415587654, 3685.355062863988, 3686.3733165361955, 3704.629537046301, 3707.8146092695256, 3708.5364329458816, 4987.501249874984, 5325.627206095575, 5330.333708286465, 5336.546393556552, 5344.6258761887075, 3631.8547258109907, 3641.4901913732097, 3643.3259846928404, 3648.0332711831384, 3662.3957047087465, 3686.5207523021836, 3694.261147770403, 3703.7407381483577, 3703.814809259526, 3710.0910276982313, 4263.658907287409, 4267.850625228102, 4270.679699022586, 4275.8075886585175, 4277.230098582223, 4864.878378040577, 5071.721055341918, 5130.538251557377, 5131.307273518102, 5131.692098474104, 1219.439058033297, 1232.3345393487596, 1237.9195352302072, 1240.8697086805937, 1241.1994263699862, 790.8256239484361, 815.2092470303915, 832.4630613254417, 840.684743221292, 842.3934766967774, 4254.787260637017, 4275.957240427618, 4276.5295817460055, 4302.763348015889, 4334.674899382559, 5034.144195486776, 5043.621728370387, 5049.899002020013, 5056.898862022739, 5069.631199576168, 4177.206330797138, 4228.4080228768, 4253.680973926967, 4279.807408666617, 4318.697691161651, 2714.7692446141905, 2727.4954133485367, 2729.863506824651, 2734.220747087071, 2741.2050505353222, 4762.571368576775, 4834.468208497063, 4836.863337115775, 4859.343988561499, 4876.878078048077, 4970.850874473772, 5197.038547868581, 5230.63385563007, 5265.552428043659, 5312.203169524525, 4796.160671882407, 4819.855404337875, 4875.268709693503, 4907.877303067452, 4909.459959404534, 5162.251473536391, 5190.247414124855, 5192.45479224676, 5204.765785539736, 5212.713300768494, 4913.385826771653, 5026.3214466048075, 5033.899322013466, 5096.108181068373, 5109.437961824271, 4789.281607758725, 4809.062232864558, 4816.446108697544, 4842.789302674331, 4871.5128487152415, 3542.4863394808126, 3553.857845686247, 3569.303985722759, 3579.302036102935, 3589.4795254688447, 4971.552560269593, 5082.103201175295, 5096.617753668415, 5101.795928162832, 5102.43873173958, 4958.206686930074, 4972.801087956441, 4982.4768399317545, 4988.079589358051, 5006.997201119581, 4963.503649635008, 4986.900261994667, 4987.526185012418, 4990.500949905126, 4998.975005124951, 4691.5308469152815, 4931.545194167657, 4940.827071052496, 4958.801647934187, 4974.701517908937, 4939.110960027229, 4945.703257804544, 5080.552042667822, 5101.7194054327365, 5101.724568857786, 5000.224965130411, 5011.674241174312, 5017.724025178651, 5018.949810501848, 5031.4213865405945], "value": 3778.660297215941, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6164427128887, 797.2266901105927, 804.8148925747082, 817.4645607127334, 830.0371568979981, 11398.0, 11963.58127465539, 12121.393930303493, 12121.999999999989, 12135.39323033847, 12296.63110106696, 12683.04877134214, 12708.618741437771, 12737.554185603505, 12753.744925101493, 669.5748199893054, 843.8565443874556, 869.2437579305997, 883.4434306386967, 883.5449743382163, 887.2369762004671, 888.5290795878195, 889.4129874282942, 889.8264838356523, 890.5680744838749, 922.8754118194058, 925.2875286029753, 925.4077390470104, 925.6019911438079, 925.7037747920668, 699.545295557889, 717.4905816870029, 718.4324383736841, 888.9466632002036, 918.5682729117337, 678.4097834883634, 683.5761827666829, 683.7504310926525, 684.1174884399119, 684.1960696181966, 13077.869221307761, 13107.0, 13112.409941552558, 13112.86887131126, 13127.803082953764, 12574.308413037279, 12833.101682882108, 13100.868991310155, 13330.467211229932, 13400.865991340059, 11161.888381116167, 11399.772004559945, 11450.713732156679, 11539.134564907581, 11906.0, 3614.331348700499, 3679.0802299425145, 3683.5027271318295, 3756.5679946806194, 3773.1699026214187, 44699.77650111729, 44731.776341118086, 44791.10417791658, 45003.77498112489, 46611.76694116541, 10255.846162307571, 10322.535485903152, 10473.31923424975, 10540.789184216426, 10690.73273168177, 18129.54676133081, 18190.45428637143, 18294.90852545729, 18406.0, 18477.90761046186, 6685.030670552743, 6717.361850624183, 6727.764528241488, 6834.2482326944, 7103.431725462054, 3645.3073915955883, 3651.94522082169, 3702.629737026276, 3723.9627603724157, 3725.2363265530503, 2850.4014157027254, 2944.160914139503, 2944.528875379929, 2944.8085874418093, 2946.882124714987, 501.6939666803247, 510.6340786277314, 516.1998901702347, 518.0623072239259, 522.1019845865181, 478.0439121756487, 513.371120377542, 556.1657513729406, 562.2999365789618, 580.3731969472959, 7115.71537138519, 7196.0, 7381.224971378036, 7382.704691812375, 7484.438667099989, 465.12324268753645, 531.8856445864158, 549.5905550365004, 555.4279092534696, 568.855884878657, 3154.2114471382156, 3283.441814891474, 3391.9152021199666, 3487.89536313911, 3521.0, 50737.49262507402, 52428.737856311236, 52730.0, 52731.736341318814, 53489.46510534923, 48345.27482087771, 48758.51241487611, 48944.0, 48988.51011489911, 49743.25385119226, 44443.555564443945, 44621.77689111599, 44755.77622111934, 45041.32438013433, 45514.77242613832, 6840.48696347766, 6899.6205208714, 6918.792436226921, 7008.334208250208, 7038.225795162426, 26310.342241444116, 29360.55959160657, 29826.701732982394, 30126.397472050874, 30492.0, 35142.47286290759, 36087.819560902026, 36262.0, 36628.0, 36740.26519469649, 9243.306751993492, 10681.946590266998, 10703.411312377893, 10889.727756806144, 10890.183236257153, 9989.300748947504, 10114.29199955996, 10190.949045254727, 10287.25583254228, 10381.377117372982, 9387.906120938977, 9592.424454532751, 9623.133917947418, 9778.16885564735, 9919.454430006419, 9741.80516389654, 10012.799744005224, 11035.11719062457, 11306.321620702454, 12245.204061735958, 10187.541560629938, 10724.839127413252, 10794.0, 10861.619843305447, 10896.237263391486, 8969.551522423722, 8975.910240897507, 9004.819903602021, 9285.767855803659, 9376.953115234654, 8339.708110216114, 8451.915480845113, 9505.382150160218, 9630.807383852423, 9652.806943861224], "value": 5918.228591194369, "unit": "score"}], "name": "dromaeo_css", "value": 6287.577303143303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 158.0, 218.0, 130.0, 155.0, 158.0, 131.0, 187.0, 129.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 146.0, 75.0, 74.0, 77.0, 76.0, 137.0, 77.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 92.0, 93.0, 93.0, 124.0, 93.0, 92.0, 126.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 64.0, 64.0, 65.0, 69.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 83.0, 82.0, 87.0, 84.0, 85.0, 83.0, 159.0, 83.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 140.0, 141.0, 131.0, 129.0, 129.0, 135.0, 132.0, 158.0, 135.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 180.0, 174.0, 174.0, 172.0, 171.0, 169.0, 172.0, 168.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 67.0, 67.0, 70.0, 69.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1579.6999999999998, "alertThreshold": 2.0}]} 04:09:40 INFO - Return code: 0 04:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:09:40 ERROR - # TBPL SUCCESS # 04:09:40 INFO - Running post-action listener: _resource_record_post_action 04:09:40 INFO - ##### 04:09:40 INFO - ##### Finished run-tests step (success) 04:09:40 INFO - ##### 04:09:40 INFO - Running post-run listener: _resource_record_post_run 04:09:41 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 9973760; Write bytes: 459423744; Read time: 1724; Write time: 463968 04:09:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 91185152; Read time: 0; Write time: 94092 04:09:41 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8212480; Write bytes: 368238592; Read time: 1684; Write time: 369876 04:09:41 INFO - Running post-run listener: _upload_blobber_files 04:09:41 INFO - Blob upload gear active. 04:09:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:41 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 04:09:41 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'] 04:09:41 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 04:09:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:42 INFO - (blobuploader) - INFO - Done attempting. 04:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:43 INFO - (blobuploader) - INFO - Done attempting. 04:09:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:43 INFO - Return code: 0 04:09:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cb2388e14484724e3e27e74387ed0fdfdde73ba6b92978854b49a045049e4b48629e452ab130d48cb2d992faa9a20ed239a561dd7cfd6b94895b961cdbefafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/979b605e62c009ed8965f50a68480c15a3f07f8b5886bcb7fe2a12d360247ff3c68581dc328fd69e1f547385ec0264cfc9e219b26cef283f292412f72a08e532"} 04:09:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:43 INFO - Contents: 04:09:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cb2388e14484724e3e27e74387ed0fdfdde73ba6b92978854b49a045049e4b48629e452ab130d48cb2d992faa9a20ed239a561dd7cfd6b94895b961cdbefafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/979b605e62c009ed8965f50a68480c15a3f07f8b5886bcb7fe2a12d360247ff3c68581dc328fd69e1f547385ec0264cfc9e219b26cef283f292412f72a08e532"} 04:09:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:43 INFO - Copying logs to upload dir... 04:09:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.484032 ========= master_lag: 718.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 44 secs) (at 2016-05-09 04:21:41.924914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:21:41.928811) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 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/2cb2388e14484724e3e27e74387ed0fdfdde73ba6b92978854b49a045049e4b48629e452ab130d48cb2d992faa9a20ed239a561dd7cfd6b94895b961cdbefafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/979b605e62c009ed8965f50a68480c15a3f07f8b5886bcb7fe2a12d360247ff3c68581dc328fd69e1f547385ec0264cfc9e219b26cef283f292412f72a08e532"} build_url:https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/W210Vp2GRBmlISoyT0QgAQ/artifacts/public/build/firefox-49.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/2cb2388e14484724e3e27e74387ed0fdfdde73ba6b92978854b49a045049e4b48629e452ab130d48cb2d992faa9a20ed239a561dd7cfd6b94895b961cdbefafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/979b605e62c009ed8965f50a68480c15a3f07f8b5886bcb7fe2a12d360247ff3c68581dc328fd69e1f547385ec0264cfc9e219b26cef283f292412f72a08e532"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:21:42.208332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:21:42.208635) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462790914.885802-534096883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:21:42.432113) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-05-09 04:21:42.432426) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-05-09 04:21:46.692230) ========= ========= Total master_lag: 718.62 =========