builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1461230593.51 results: success (0) buildid: 20160421012904 builduid: bb5d1c29981040b5a68293158eb3d86e revision: 387167675e152537dd5538a61d07c155a4fabdd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.505997) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.506681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.506969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.537974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.538254) ========= 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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 02:23:14-- 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% 59.9M=0s 2016-04-21 02:23:15 (59.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.350121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.902368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.902700) ========= 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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.953998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:13.954401) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 387167675e152537dd5538a61d07c155a4fabdd0 --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 387167675e152537dd5538a61d07c155a4fabdd0 --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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 02:23:15,256 truncating revision to first 12 chars 2016-04-21 02:23:15,256 Setting DEBUG logging. 2016-04-21 02:23:15,256 attempt 1/10 2016-04-21 02:23:15,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/387167675e15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 02:23:15,503 unpacking tar archive at: fx-team-387167675e15/testing/mozharness/ program finished with exit code 0 elapsedTime=0.500234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:14.467717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:14.468039) ========= script_repo_revision: 387167675e152537dd5538a61d07c155a4fabdd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:14.468471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:14.468738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 02:23:14.476717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-21 02:23:14.477020) ========= /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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:15 INFO - MultiFileLogger online at 20160421 02:23:15 in /builds/slave/test 02:23:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:23:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:23:15 INFO - {'append_to_log': False, 02:23:15 INFO - 'base_work_dir': '/builds/slave/test', 02:23:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:23:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:23:15 INFO - 'branch': 'Fx-Team-Non-PGO', 02:23:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:15 INFO - 'config_files': ('talos/linux_config.py',), 02:23:15 INFO - 'default_actions': ('clobber', 02:23:15 INFO - 'read-buildbot-config', 02:23:15 INFO - 'download-and-extract', 02:23:15 INFO - 'populate-webroot', 02:23:15 INFO - 'create-virtualenv', 02:23:15 INFO - 'install', 02:23:15 INFO - 'run-tests'), 02:23:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:15 INFO - 'download_minidump_stackwalk': True, 02:23:15 INFO - 'download_symbols': 'ondemand', 02:23:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:15 INFO - 'installer_path': 'installer.exe', 02:23:15 INFO - 'log_level': 'info', 02:23:15 INFO - 'log_name': 'talos', 02:23:15 INFO - 'log_to_console': True, 02:23:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:15 INFO - 'opt_config_files': (), 02:23:15 INFO - 'pip_index': False, 02:23:15 INFO - 'sps_profile': False, 02:23:15 INFO - 'sps_profile_interval': 0, 02:23:15 INFO - 'suite': 'dromaeojs', 02:23:15 INFO - 'system_bits': '32', 02:23:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:15 INFO - 'title': 'talos-linux64-ix-025', 02:23:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:15 INFO - 'use_talos_json': True, 02:23:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:23:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:15 INFO - 'work_dir': 'build'} 02:23:15 INFO - ##### 02:23:15 INFO - ##### Running clobber step. 02:23:15 INFO - ##### 02:23:15 INFO - Running pre-action listener: _resource_record_pre_action 02:23:15 INFO - Running main action method: clobber 02:23:15 INFO - rmtree: /builds/slave/test/build 02:23:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:23:16 INFO - Running post-action listener: _resource_record_post_action 02:23:16 INFO - ##### 02:23:16 INFO - ##### Running read-buildbot-config step. 02:23:16 INFO - ##### 02:23:16 INFO - Running pre-action listener: _resource_record_pre_action 02:23:16 INFO - Running main action method: read_buildbot_config 02:23:16 INFO - Using buildbot properties: 02:23:16 INFO - { 02:23:16 INFO - "project": "", 02:23:16 INFO - "product": "firefox", 02:23:16 INFO - "script_repo_revision": "production", 02:23:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:23:16 INFO - "repository": "", 02:23:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:23:16 INFO - "buildid": "20160421012904", 02:23:16 INFO - "pgo_build": "False", 02:23:16 INFO - "basedir": "/builds/slave/test", 02:23:16 INFO - "buildnumber": 1694, 02:23:16 INFO - "slavename": "talos-linux64-ix-025", 02:23:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:23:16 INFO - "platform": "ubuntu64_hw", 02:23:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:23:16 INFO - "branch": "fx-team", 02:23:16 INFO - "repo_path": "integration/fx-team", 02:23:16 INFO - "revision": "387167675e152537dd5538a61d07c155a4fabdd0", 02:23:16 INFO - "stage_platform": "linux64", 02:23:16 INFO - "builduid": "bb5d1c29981040b5a68293158eb3d86e", 02:23:16 INFO - "slavebuilddir": "test" 02:23:16 INFO - } 02:23:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:23:16 INFO - Running post-action listener: _resource_record_post_action 02:23:16 INFO - ##### 02:23:16 INFO - ##### Running download-and-extract step. 02:23:16 INFO - ##### 02:23:16 INFO - Running pre-action listener: _resource_record_pre_action 02:23:16 INFO - Running main action method: download_and_extract 02:23:16 INFO - mkdir: /builds/slave/test/build/tests 02:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:16 INFO - https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:23:24 INFO - Downloaded 1361 bytes. 02:23:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:23:24 INFO - Using the following test package requirements: 02:23:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:23:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'jsshell-linux-x86_64.zip'], 02:23:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:23:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:23:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23:24 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')]} 02:23:24 INFO - https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:28 INFO - Downloaded 22275480 bytes. 02:23:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:29 INFO - Return code: 0 02:23:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:23: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')]} 02:23:29 INFO - https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:35 INFO - Downloaded 22275480 bytes. 02:23:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:36 INFO - Return code: 0 02:23:36 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')]} 02:23:36 INFO - https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:23:38 INFO - Downloaded 10845952 bytes. 02:23:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:23:38 INFO - Return code: 0 02:23:38 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')]} 02:23:38 INFO - https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:23:39 INFO - Downloaded 54659001 bytes. 02:23:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:23:39 INFO - mkdir: /builds/slave/test/properties 02:23:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:23:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:23:39 INFO - Contents: 02:23:39 INFO - build_url:https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:23:40 INFO - Running post-action listener: _resource_record_post_action 02:23:40 INFO - Running post-action listener: set_extra_try_arguments 02:23:40 INFO - ##### 02:23:40 INFO - ##### Running populate-webroot step. 02:23:40 INFO - ##### 02:23:40 INFO - Running pre-action listener: _resource_record_pre_action 02:23:40 INFO - Running main action method: populate_webroot 02:23:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:40 INFO - '--tppagecycles', 02:23:40 INFO - '7'], 02:23:40 INFO - 'tests': ['tsvgm']}}, 02:23:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:23:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:23:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:23:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['damp', 'tps']}, 02:23:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'tests': ['damp', 'tps']}, 02:23:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['dromaeo_dom']}, 02:23:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['a11yr', 02:23:40 INFO - 'ts_paint', 02:23:40 INFO - 'tpaint', 02:23:40 INFO - 'sessionrestore', 02:23:40 INFO - 'sessionrestore_no_auto_restore', 02:23:40 INFO - 'tabpaint']}, 02:23:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['tsvgx', 02:23:40 INFO - 'tsvgr_opacity', 02:23:40 INFO - 'tart', 02:23:40 INFO - 'tscrollx', 02:23:40 INFO - 'cart']}, 02:23:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:23:40 INFO - 'tsvgr_opacity', 02:23:40 INFO - 'tart', 02:23:40 INFO - 'tscrollx', 02:23:40 INFO - 'cart']}, 02:23:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'talos_options': ['--disable-e10s'], 02:23:40 INFO - 'tests': ['tp5o']}, 02:23:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'tests': ['tp5o']}, 02:23:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'talos_options': ['--disable-e10s', 02:23:40 INFO - '--xperf_path', 02:23:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:40 INFO - 'tests': ['tp5n']}, 02:23:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:40 INFO - 'talos_options': ['--xperf_path', 02:23:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:40 INFO - 'tests': ['tp5n']}}, 02:23:40 INFO - 'talos.zip': {'path': '', 02:23:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:40 INFO - Running post-action listener: _resource_record_post_action 02:23:40 INFO - ##### 02:23:40 INFO - ##### Running create-virtualenv step. 02:23:40 INFO - ##### 02:23:40 INFO - Running pre-action listener: _resource_record_pre_action 02:23:40 INFO - Running main action method: create_virtualenv 02:23:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:23:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:23:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:23:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:23:40 INFO - Using real prefix '/usr' 02:23:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:23:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:23:43 INFO - Installing pip.................done. 02:23:43 INFO - Return code: 0 02:23:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:23:43 INFO - Using env: {'DISPLAY': ':0', 02:23:43 INFO - 'HOME': '/home/cltbld', 02:23:43 INFO - 'LANG': 'en_US.UTF-8', 02:23:43 INFO - 'LANGUAGE': 'en_US:en', 02:23:43 INFO - 'LOGNAME': 'cltbld', 02:23:43 INFO - 'MAIL': '/var/mail/cltbld', 02:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:43 INFO - 'MOZ_NO_REMOTE': '1', 02:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:43 INFO - 'NO_EM_RESTART': '1', 02:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:43 INFO - 'PWD': '/builds/slave/test', 02:23:43 INFO - 'SHELL': '/bin/bash', 02:23:43 INFO - 'SHLVL': '1', 02:23:43 INFO - 'TERM': 'linux', 02:23:43 INFO - 'TMOUT': '86400', 02:23:43 INFO - 'USER': 'cltbld', 02:23:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:43 INFO - '_': '/tools/buildbot/bin/python'} 02:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:23:43 INFO - Cleaning up... 02:23:43 INFO - Return code: 0 02:23:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:43 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 02:23:43 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 02:23:43 INFO - Using env: {'DISPLAY': ':0', 02:23:43 INFO - 'HOME': '/home/cltbld', 02:23:43 INFO - 'LANG': 'en_US.UTF-8', 02:23:43 INFO - 'LANGUAGE': 'en_US:en', 02:23:43 INFO - 'LOGNAME': 'cltbld', 02:23:43 INFO - 'MAIL': '/var/mail/cltbld', 02:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:43 INFO - 'MOZ_NO_REMOTE': '1', 02:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:43 INFO - 'NO_EM_RESTART': '1', 02:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:43 INFO - 'PWD': '/builds/slave/test', 02:23:43 INFO - 'SHELL': '/bin/bash', 02:23:43 INFO - 'SHLVL': '1', 02:23:43 INFO - 'TERM': 'linux', 02:23:43 INFO - 'TMOUT': '86400', 02:23:43 INFO - 'USER': 'cltbld', 02:23:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:43 INFO - '_': '/tools/buildbot/bin/python'} 02:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:43 INFO - Downloading/unpacking psutil>=0.7.1 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:46 INFO - Installing collected packages: psutil 02:23:46 INFO - Running setup.py install for psutil 02:23:46 INFO - building 'psutil._psutil_linux' extension 02:23:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:23:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:23:46 INFO - building 'psutil._psutil_posix' extension 02:23:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:23:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:47 INFO - Successfully installed psutil 02:23:47 INFO - Cleaning up... 02:23:47 INFO - Return code: 0 02:23:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:47 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:47 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 02:23:47 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 02:23:47 INFO - Using env: {'DISPLAY': ':0', 02:23:47 INFO - 'HOME': '/home/cltbld', 02:23:47 INFO - 'LANG': 'en_US.UTF-8', 02:23:47 INFO - 'LANGUAGE': 'en_US:en', 02:23:47 INFO - 'LOGNAME': 'cltbld', 02:23:47 INFO - 'MAIL': '/var/mail/cltbld', 02:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:47 INFO - 'MOZ_NO_REMOTE': '1', 02:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:47 INFO - 'NO_EM_RESTART': '1', 02:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:47 INFO - 'PWD': '/builds/slave/test', 02:23:47 INFO - 'SHELL': '/bin/bash', 02:23:47 INFO - 'SHLVL': '1', 02:23:47 INFO - 'TERM': 'linux', 02:23:47 INFO - 'TMOUT': '86400', 02:23:47 INFO - 'USER': 'cltbld', 02:23:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:47 INFO - '_': '/tools/buildbot/bin/python'} 02:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:23:49 INFO - Installing collected packages: mozsystemmonitor 02:23:49 INFO - Running setup.py install for mozsystemmonitor 02:23:49 INFO - Successfully installed mozsystemmonitor 02:23:49 INFO - Cleaning up... 02:23:49 INFO - Return code: 0 02:23:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:23:49 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')]} 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:49 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')]} 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:49 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:23:49 INFO - Using env: {'DISPLAY': ':0', 02:23:49 INFO - 'HOME': '/home/cltbld', 02:23:49 INFO - 'LANG': 'en_US.UTF-8', 02:23:49 INFO - 'LANGUAGE': 'en_US:en', 02:23:49 INFO - 'LOGNAME': 'cltbld', 02:23:49 INFO - 'MAIL': '/var/mail/cltbld', 02:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:49 INFO - 'MOZ_NO_REMOTE': '1', 02:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:49 INFO - 'NO_EM_RESTART': '1', 02:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:49 INFO - 'PWD': '/builds/slave/test', 02:23:49 INFO - 'SHELL': '/bin/bash', 02:23:49 INFO - 'SHLVL': '1', 02:23:49 INFO - 'TERM': 'linux', 02:23:49 INFO - 'TMOUT': '86400', 02:23:49 INFO - 'USER': 'cltbld', 02:23:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:49 INFO - '_': '/tools/buildbot/bin/python'} 02:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:23:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:23:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:52 INFO - Downloading docopt-0.6.1.tar.gz 02:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:23:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:23:52 INFO - Running setup.py install for blobuploader 02:23:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:23:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:23:52 INFO - Running setup.py install for requests 02:23:52 INFO - Running setup.py install for docopt 02:23:52 INFO - Successfully installed blobuploader requests docopt 02:23:52 INFO - Cleaning up... 02:23:52 INFO - Return code: 0 02:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:52 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:52 INFO - Using env: {'DISPLAY': ':0', 02:23:52 INFO - 'HOME': '/home/cltbld', 02:23:52 INFO - 'LANG': 'en_US.UTF-8', 02:23:52 INFO - 'LANGUAGE': 'en_US:en', 02:23:52 INFO - 'LOGNAME': 'cltbld', 02:23:52 INFO - 'MAIL': '/var/mail/cltbld', 02:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:52 INFO - 'MOZ_NO_REMOTE': '1', 02:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:52 INFO - 'NO_EM_RESTART': '1', 02:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:52 INFO - 'PWD': '/builds/slave/test', 02:23:52 INFO - 'SHELL': '/bin/bash', 02:23:52 INFO - 'SHLVL': '1', 02:23:52 INFO - 'TERM': 'linux', 02:23:52 INFO - 'TMOUT': '86400', 02:23:52 INFO - 'USER': 'cltbld', 02:23:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:52 INFO - '_': '/tools/buildbot/bin/python'} 02:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:52 INFO - Running setup.py (path:/tmp/pip-a7ihkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:53 INFO - Running setup.py (path:/tmp/pip-QtfAAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:53 INFO - Running setup.py (path:/tmp/pip-Ae1azE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:53 INFO - Running setup.py (path:/tmp/pip-tXvh91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:53 INFO - Running setup.py (path:/tmp/pip-DvOhe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:53 INFO - Running setup.py (path:/tmp/pip-jOdQRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:53 INFO - Running setup.py (path:/tmp/pip-BS9VPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:53 INFO - Running setup.py (path:/tmp/pip-OS7KvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:53 INFO - Running setup.py (path:/tmp/pip-Zrlrhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:53 INFO - Running setup.py (path:/tmp/pip-2YTzFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:53 INFO - Running setup.py (path:/tmp/pip-4RN5AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:53 INFO - Running setup.py (path:/tmp/pip-9qaUUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:53 INFO - Running setup.py (path:/tmp/pip-sxWGxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:53 INFO - Running setup.py (path:/tmp/pip-CdYjd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:53 INFO - Running setup.py (path:/tmp/pip-w1_IXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:54 INFO - Running setup.py (path:/tmp/pip-PtIdRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:54 INFO - Running setup.py (path:/tmp/pip-IHwEo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:54 INFO - Running setup.py install for manifestparser 02:23:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:23:54 INFO - Running setup.py install for mozcrash 02:23:54 INFO - Running setup.py install for mozdebug 02:23:54 INFO - Running setup.py install for mozdevice 02:23:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:23:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:23:54 INFO - Running setup.py install for mozfile 02:23:54 INFO - Running setup.py install for mozhttpd 02:23:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:23:54 INFO - Running setup.py install for mozinfo 02:23:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:23:54 INFO - Running setup.py install for mozInstall 02:23:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Running setup.py install for mozleak 02:23:55 INFO - Running setup.py install for mozlog 02:23:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Running setup.py install for moznetwork 02:23:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Running setup.py install for mozprocess 02:23:55 INFO - Running setup.py install for mozprofile 02:23:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Running setup.py install for mozrunner 02:23:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:23:55 INFO - Running setup.py install for mozscreenshot 02:23:55 INFO - Running setup.py install for moztest 02:23:55 INFO - Running setup.py install for mozversion 02:23:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:56 INFO - Cleaning up... 02:23:56 INFO - Return code: 0 02:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:56 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')]} 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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')]} 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:56 INFO - Using env: {'DISPLAY': ':0', 02:23:56 INFO - 'HOME': '/home/cltbld', 02:23:56 INFO - 'LANG': 'en_US.UTF-8', 02:23:56 INFO - 'LANGUAGE': 'en_US:en', 02:23:56 INFO - 'LOGNAME': 'cltbld', 02:23:56 INFO - 'MAIL': '/var/mail/cltbld', 02:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:56 INFO - 'MOZ_NO_REMOTE': '1', 02:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:56 INFO - 'NO_EM_RESTART': '1', 02:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:56 INFO - 'PWD': '/builds/slave/test', 02:23:56 INFO - 'SHELL': '/bin/bash', 02:23:56 INFO - 'SHLVL': '1', 02:23:56 INFO - 'TERM': 'linux', 02:23:56 INFO - 'TMOUT': '86400', 02:23:56 INFO - 'USER': 'cltbld', 02:23:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:56 INFO - '_': '/tools/buildbot/bin/python'} 02:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:56 INFO - Running setup.py (path:/tmp/pip-N4bJ6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:56 INFO - Running setup.py (path:/tmp/pip-SkMTwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:56 INFO - Running setup.py (path:/tmp/pip-hezV0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:56 INFO - Running setup.py (path:/tmp/pip-2tsS3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:56 INFO - Running setup.py (path:/tmp/pip-5tIiua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:56 INFO - Running setup.py (path:/tmp/pip-Q2CLYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:56 INFO - Running setup.py (path:/tmp/pip-aNQvOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:56 INFO - Running setup.py (path:/tmp/pip-MYX8dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:56 INFO - Running setup.py (path:/tmp/pip-8OU4GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:56 INFO - Running setup.py (path:/tmp/pip-USC2Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:56 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)) 02:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:56 INFO - Running setup.py (path:/tmp/pip-wbrhNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:57 INFO - Running setup.py (path:/tmp/pip-YQhuyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:57 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)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:57 INFO - Running setup.py (path:/tmp/pip-iRjwTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:57 INFO - Running setup.py (path:/tmp/pip-SFfbGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:57 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)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:57 INFO - Running setup.py (path:/tmp/pip-M50iz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:57 INFO - Running setup.py (path:/tmp/pip-2_hvda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:57 INFO - Running setup.py (path:/tmp/pip-gGC4WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:59 INFO - Downloading blessings-1.6.tar.gz 02:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:59 INFO - Installing collected packages: blessings 02:23:59 INFO - Running setup.py install for blessings 02:23:59 INFO - Successfully installed blessings 02:23:59 INFO - Cleaning up... 02:23:59 INFO - Return code: 0 02:23:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:59 INFO - Reading from file tmpfile_stdout 02:23:59 INFO - Current package versions: 02:23:59 INFO - argparse == 1.2.1 02:23:59 INFO - blessings == 1.6 02:23:59 INFO - blobuploader == 1.2.4 02:23:59 INFO - docopt == 0.6.1 02:23:59 INFO - manifestparser == 1.1 02:23:59 INFO - mozInstall == 1.12 02:23:59 INFO - mozcrash == 0.17 02:23:59 INFO - mozdebug == 0.1 02:23:59 INFO - mozdevice == 0.48 02:23:59 INFO - mozfile == 1.2 02:23:59 INFO - mozhttpd == 0.7 02:23:59 INFO - mozinfo == 0.9 02:23:59 INFO - mozleak == 0.1 02:23:59 INFO - mozlog == 3.1 02:23:59 INFO - moznetwork == 0.27 02:23:59 INFO - mozprocess == 0.22 02:23:59 INFO - mozprofile == 0.28 02:23:59 INFO - mozrunner == 6.11 02:23:59 INFO - mozscreenshot == 0.1 02:23:59 INFO - mozsystemmonitor == 0.0 02:23:59 INFO - moztest == 0.7 02:23:59 INFO - mozversion == 1.4 02:23:59 INFO - psutil == 3.1.1 02:23:59 INFO - requests == 1.2.3 02:23:59 INFO - wsgiref == 0.1.2 02:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:59 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:59 INFO - Using env: {'DISPLAY': ':0', 02:23:59 INFO - 'HOME': '/home/cltbld', 02:23:59 INFO - 'LANG': 'en_US.UTF-8', 02:23:59 INFO - 'LANGUAGE': 'en_US:en', 02:23:59 INFO - 'LOGNAME': 'cltbld', 02:23:59 INFO - 'MAIL': '/var/mail/cltbld', 02:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:59 INFO - 'MOZ_NO_REMOTE': '1', 02:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:59 INFO - 'NO_EM_RESTART': '1', 02:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:59 INFO - 'PWD': '/builds/slave/test', 02:23:59 INFO - 'SHELL': '/bin/bash', 02:23:59 INFO - 'SHLVL': '1', 02:23:59 INFO - 'TERM': 'linux', 02:23:59 INFO - 'TMOUT': '86400', 02:23:59 INFO - 'USER': 'cltbld', 02:23:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:59 INFO - '_': '/tools/buildbot/bin/python'} 02:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:00 INFO - Cleaning up... 02:24:00 INFO - Return code: 0 02:24:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:00 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')]} 02:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:00 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')]} 02:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:00 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:24:00 INFO - Using env: {'DISPLAY': ':0', 02:24:00 INFO - 'HOME': '/home/cltbld', 02:24:00 INFO - 'LANG': 'en_US.UTF-8', 02:24:00 INFO - 'LANGUAGE': 'en_US:en', 02:24:00 INFO - 'LOGNAME': 'cltbld', 02:24:00 INFO - 'MAIL': '/var/mail/cltbld', 02:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:00 INFO - 'MOZ_NO_REMOTE': '1', 02:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:00 INFO - 'NO_EM_RESTART': '1', 02:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:00 INFO - 'PWD': '/builds/slave/test', 02:24:00 INFO - 'SHELL': '/bin/bash', 02:24:00 INFO - 'SHLVL': '1', 02:24:00 INFO - 'TERM': 'linux', 02:24:00 INFO - 'TMOUT': '86400', 02:24:00 INFO - 'USER': 'cltbld', 02:24:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:00 INFO - '_': '/tools/buildbot/bin/python'} 02:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:00 INFO - Downloading/unpacking jsonschema 02:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:02 INFO - Downloading/unpacking functools32 (from jsonschema) 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:02 INFO - warning: no files found matching '*.txt' 02:24:02 INFO - no previously-included directories found matching 'build' 02:24:02 INFO - no previously-included directories found matching 'dist' 02:24:02 INFO - no previously-included directories found matching '.git*' 02:24:02 INFO - Installing collected packages: jsonschema, functools32 02:24:02 INFO - Running setup.py install for functools32 02:24:02 INFO - warning: no files found matching '*.txt' 02:24:02 INFO - no previously-included directories found matching 'build' 02:24:02 INFO - no previously-included directories found matching 'dist' 02:24:02 INFO - no previously-included directories found matching '.git*' 02:24:02 INFO - Successfully installed jsonschema functools32 02:24:02 INFO - Cleaning up... 02:24:02 INFO - Return code: 0 02:24:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:24:02 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')]} 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 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')]} 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 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 0x7f8df72ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, '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': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:02 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 02:24:02 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 02:24:02 INFO - Using env: {'DISPLAY': ':0', 02:24:02 INFO - 'HOME': '/home/cltbld', 02:24:02 INFO - 'LANG': 'en_US.UTF-8', 02:24:02 INFO - 'LANGUAGE': 'en_US:en', 02:24:02 INFO - 'LOGNAME': 'cltbld', 02:24:02 INFO - 'MAIL': '/var/mail/cltbld', 02:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:02 INFO - 'MOZ_NO_REMOTE': '1', 02:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:02 INFO - 'NO_EM_RESTART': '1', 02:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:02 INFO - 'PWD': '/builds/slave/test', 02:24:02 INFO - 'SHELL': '/bin/bash', 02:24:02 INFO - 'SHLVL': '1', 02:24:02 INFO - 'TERM': 'linux', 02:24:02 INFO - 'TMOUT': '86400', 02:24:02 INFO - 'USER': 'cltbld', 02:24:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:02 INFO - '_': '/tools/buildbot/bin/python'} 02:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:02 INFO - Downloading/unpacking flake8 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:05 INFO - no previously-included directories found matching 'docs/_build' 02:24:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:05 INFO - Running setup.py install for pep8 02:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:05 INFO - no previously-included directories found matching 'docs/_build' 02:24:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:24:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:05 INFO - Cleaning up... 02:24:05 INFO - Return code: 0 02:24:05 INFO - Running post-action listener: _resource_record_post_action 02:24:05 INFO - Running post-action listener: _start_resource_monitoring 02:24:05 INFO - Starting resource monitoring. 02:24:05 INFO - ##### 02:24:05 INFO - ##### Running install step. 02:24:05 INFO - ##### 02:24:05 INFO - Running pre-action listener: _resource_record_pre_action 02:24:05 INFO - Running main action method: install 02:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:05 INFO - Reading from file tmpfile_stdout 02:24:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:24:05 INFO - Reading from file tmpfile_stdout 02:24:05 INFO - Output received: 02:24:05 INFO - Usage: mozinstall [options] installer 02:24:05 INFO - Options: 02:24:05 INFO - -h, --help show this help message and exit 02:24:05 INFO - -d DEST, --destination=DEST 02:24:05 INFO - Directory to install application into. [default: 02:24:05 INFO - "/builds/slave/test"] 02:24:05 INFO - --app=APP Application being installed. [default: firefox] 02:24:05 INFO - mkdir: /builds/slave/test/build/application 02:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:24:21 INFO - Reading from file tmpfile_stdout 02:24:21 INFO - Output received: 02:24:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:24:21 INFO - Running post-action listener: _resource_record_post_action 02:24:21 INFO - ##### 02:24:21 INFO - ##### Running run-tests step. 02:24:21 INFO - ##### 02:24:21 INFO - Running pre-action listener: _resource_record_pre_action 02:24:21 INFO - Running main action method: run_tests 02:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:24:21 INFO - Python 2.7.3 02:24:21 INFO - Return code: 0 02:24:21 INFO - grabbing minidump binary from tooltool 02:24:21 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')]} 02:24:21 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 0x1ee0410>, '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 0x1ee1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:24:21 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 02:24:21 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 02:24:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:21 INFO - Return code: 0 02:24:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:24:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:24:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:24:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:24:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:24:22 INFO - Return code: 0 02:24:22 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/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:24:22 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/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 02:24:22 INFO - Using env: {'DISPLAY': ':0', 02:24:22 INFO - 'HOME': '/home/cltbld', 02:24:22 INFO - 'LANG': 'en_US.UTF-8', 02:24:22 INFO - 'LANGUAGE': 'en_US:en', 02:24:22 INFO - 'LOGNAME': 'cltbld', 02:24:22 INFO - 'MAIL': '/var/mail/cltbld', 02:24:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:24:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:22 INFO - 'MOZ_NO_REMOTE': '1', 02:24:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:22 INFO - 'NO_EM_RESTART': '1', 02:24:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:22 INFO - 'PWD': '/builds/slave/test', 02:24:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:24:22 INFO - 'SHELL': '/bin/bash', 02:24:22 INFO - 'SHLVL': '1', 02:24:22 INFO - 'TERM': 'linux', 02:24:22 INFO - 'TMOUT': '86400', 02:24:22 INFO - 'USER': 'cltbld', 02:24:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461224125.191780-823850238', 02:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:22 INFO - '_': '/tools/buildbot/bin/python'} 02:24:22 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/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:24:22 INFO - mozversion application_buildid: 20160421012904 02:24:22 INFO - mozversion application_changeset: 387167675e152537dd5538a61d07c155a4fabdd0 02:24:22 INFO - mozversion application_display_name: Nightly 02:24:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:22 INFO - mozversion application_name: Firefox 02:24:22 INFO - mozversion application_remotingname: firefox 02:24:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:24:22 INFO - mozversion application_vendor: Mozilla 02:24:22 INFO - mozversion application_version: 48.0a1 02:24:22 INFO - mozversion platform_buildid: 20160421012904 02:24:22 INFO - mozversion platform_changeset: 387167675e152537dd5538a61d07c155a4fabdd0 02:24:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:24:22 INFO - mozversion platform_version: 48.0a1 02:24:22 INFO - using testdate: 1461230662 02:24:22 INFO - actual date: 1461230662 02:24:22 INFO - starting webserver on 'localhost:43377' 02:24:22 INFO - SUITE-START | Running 2 tests 02:24:22 INFO - TEST-START | dromaeo_css 02:24:22 INFO - operating with platform_type : linux_ 02:24:22 INFO - Initialising browser for dromaeo_css test... 02:24:22 INFO - TEST-INFO | started process 15597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQrKWR/profile http://localhost:43377/getInfo.html) 02:24:27 INFO - PROCESS | 15597 | __metrics Screen width/height:1600/1200 02:24:27 INFO - PROCESS | 15597 | colorDepth:24 02:24:27 INFO - PROCESS | 15597 | Browser inner width/height: 1024/697 02:24:27 INFO - PROCESS | 15597 | __metrics 02:24:28 ERROR - PROCESS | 15597 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:24:29 INFO - TEST-INFO | 15597: exit 0 02:24:29 INFO - Browser initialized. 02:24:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:24:29 INFO - TEST-INFO | started process 15679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQrKWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:41 INFO - PROCESS | 15679 | RSS: Main: 155160576 02:24:41 INFO - PROCESS | 15679 | 02:25:32 INFO - PROCESS | 15679 | 1461230732755 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] 02:27:44 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43377/tests/dromaeo/cssquery-ext.html) 02:27:45 INFO - PROCESS | 15679 | RSS: Main: 260341760 02:27:45 INFO - PROCESS | 15679 | 02:30:48 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-ext.html (next: http://localhost:43377/tests/dromaeo/cssquery-jquery.html) 02:30:49 INFO - PROCESS | 15679 | RSS: Main: 226029568 02:30:49 INFO - PROCESS | 15679 | 02:33:51 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43377/tests/dromaeo/cssquery-mootools.html) 02:33:51 INFO - PROCESS | 15679 | RSS: Main: 227926016 02:33:51 INFO - PROCESS | 15679 | 02:36:54 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43377/tests/dromaeo/cssquery-prototype.html) 02:36:54 INFO - PROCESS | 15679 | RSS: Main: 231247872 02:36:54 INFO - PROCESS | 15679 | 02:39:57 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43377/tests/dromaeo/cssquery-yui.html) 02:39:58 INFO - PROCESS | 15679 | RSS: Main: 213737472 02:39:58 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-yui.html (next: http://localhost:43377/tests/dromaeo/cssquery-dojo.html) 02:43:01 INFO - PROCESS | 15679 | RSS: Main: 268910592 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | __start_tp_report 02:43:01 INFO - PROCESS | 15679 | _x_x_mozilla_page_load 02:43:01 INFO - PROCESS | 15679 | _x_x_mozilla_page_load_details 02:43:01 INFO - PROCESS | 15679 | |i|pagename|runs| 02:43:01 INFO - PROCESS | 15679 | |0;dojo.html;2558.8868842053703;2642.035656985199;2648.7616114549687;2667.439837634097;2686.3149896776326;4529.818807247714;4572.017016341486;4653.790579423926;4680.227762419201;4695.131400690874;4623.42207224097;4653.395058642372;4688.991866748648;4694.812207511695;4707.576318131368;4192.7484350938885;4206.600372964564;4213.978930105345;4280.74315541067;4387.4296341475565;4325.243082460573;4377.627901628365;4407.427034485512;4416.293393057112;4433.401490798733;4134.193832202722;4179.874603761892;4196.538380778112;4316.676249281317;4331.32864406016;4216.57834216579;4221.852235171754;4221.873343799691;4223.155368926196;4251.893702657428;4190.706650534464;4218.34615634574;4221.282381995037;4234.216669916075;4258.105797782469;4522.66080043998;4530.569595888385;4532.116237333721;4542.70472419295;4586.977065114653;4833.081714474239;4874.585660218886;4944.505549445063;4944.851654450372;4966.453690094087;4965.826196083156;4969.478204788517;4971.776270067856;4972.179590367585;5004.324416203839;4625.444946606395;4637.46669133054;4640.187967105777;4640.512746161672;4645.349651048856;4882.487338829443;5056.393232812086;5073.797048118034;5134.409542902614;5160.458151894072;4844.418669759581;4862.270659401118;4863.829765958245;4870.342503762017;4915.361003069578;4945.208766597327;4946.109700253917;4955.98402327522;4957.479464656231;4994.026164897883;4755.595774359218;4944.258361245842;4972.229304457815;5029.924551131736;5031.874203144951;4852.393450818648;4871.8294859679745;4878.07316609843;4878.731669758126;4931.112399768076;4002.7198096133575;4077.103037331782;4089.3048181809163;4095.385692146202;4129.772862492592;3616.023673608111;3621.9637803622154;3624.2026754114054;3669.1377526281303;3718.7025037996896;4221.197972385237;4246.150769846043;4254.659627229814;4272.978635106804;4285.442892424027;4705.529447055267;4813.446453657804;4841.975790121027;4850.660453768202;4895.877603059881;4245.575442455792;4281.165172791276;4299.9785001075425;4323.762193079411;4342.044750154961;4443.688941774045;4453.643708503312;4461.5092339842595;4499.0776890737325;4503.211937910918;4519.209138400833;4665.440147182224;4743.857684269408;4744;4751.667383283137;4987.950120498748;4993.900121997613;5000.449950505515;5001.624878134082;5052;4723.102610503994;4771.475137734777;4774.665773395829;4789.7605119743175;4827.106985207748;4747.715137091785;4801.135795556834;4869.683470574401;4941.65408421407;4985.451600323889;4914.115459217375;4924.187509060965;4930.087933732271;4931.0630980113665;4980.153373926513;4785.353977213032;4789.473157952692;4803.567678908915;4851.2723091535145;4851.490593487633;4703.788329525248;4762.547557981986;4769.785359658755;4859.441164266154;4875.195592727302;4745.1221524018165;4754;4757.14371413149;4761.262004389325;4785.688930219525;4864.902701946012;4870.878228044327;4872.610191184625;4873.756312184306;4919.901601967869;4582.381378513858;4664.510226426177;4737.431508219036;4786.856394308176;4844.733539655353 02:43:01 INFO - PROCESS | 15679 | |1;ext.html;554.7309554865892;594.5332913662776;595.3362001368473;598.3478008970221;598.6677394046304;33586.66413335869;34668.47997280036;34672.479912801326;34706.479402808945;34734.30531389374;36274;37036.81481592595;37073;37258.62741372585;37299.25401491969;7254.673539690701;7322.48742588019;7380.409567234635;7381.630918454082;7777.10563285221;7363.889541656879;9662.855057174149;10052.14556762676;10065.698029059104;10067;9711.951440242825;9792.853107203362;9817.410955342666;9821.65624203153;9823.165030972375;7670.654820533034;7943.324817390529;9577.090176433228;9696.660616878446;9705.223582113449;7579.772606821749;9453.858192127123;9716.514174291327;9725;9733.90266097337;34833.129171770655;35528.28943421143;35553.28893422143;35661.46507802385;35698.464523031915;3097.132802815215;3209.1495753625077;3354.9496757548654;3402.1494626343415;3553.7690050146657;28863.711362886523;29382.706172938426;29854.122242372254;30527.236819079477;30830.229244269074;3429.725621950263;3452.2577645806273;3496.8950931472095;3517.736169787276;3530.841112149934;292413;299954;300428;300665;301510;57044.429555704744;57512.13731793943;57804.4219557799;58028.70985645129;58058;60742.392576073675;61834;63216;65106.674466627366;65306.67346663236;12175.573854915036;12180.878191218151;12192.939035304767;12202.877971220352;12209.206401583868;9978.451185184884;10726;11070.501827417786;11207.887921120848;11331.546738130382;18215.72676409855;18326.541836454195;18335.449936501926;18434.170462329228;18435.631287374177;6886;7110.92889071113;7348.52234604749;7361.2638736125955;7409.407247420193;908.1871724806261;943.5895385507326;959.9776238306182;965.5992763003275;980.4852452462371;27401;28792.42415151685;29018.27454313659;31576.684233157834;32148.35703285921;1012.4229189361993;1025.6410256410345;1037.6057098302747;1060.7454210989306;1062.829947208443;14307.92846035763;14839.851601484062;14970.401183952737;15043.194816622075;15121.848781512264;332250;339125;339126;339553;340219;48504.5149548507;49391.25913111306;49435;49453.75273123611;49510.257346139835;1106.7952428800697;1108.922375433712;1166.5683697032152;1264.9557265495664;1271.1165739810742;25104.246872593852;26007.219783406526;26029.6095558563;26242.868785655948;28309.29226769265;41411;41903.37144942767;42227.155456890076;42366.36450453184;42413.78793106015;277173;277436;279281;279842;280080;21924.890375548657;25589.3602659935;25633.10284140046;26224.08215712441;26255.73744262533;36134.88369782727;36232.09419764527;39020.60979390283;39319.606803931594;39327;33464;33528.32943341168;33894.491582625786;34466.82766586151;34795.65204347924;32914.83542582272;34216.65783342135;34594.30811383809;34723.65276347204;35046.299074017865;34032.829835850665;34109.82945085358;34416.311673765886;34796.13009674779;34858.65141348554;30145.47937422393;30973.33193422238;31187.84406077955;31302;31384.95365165085;24574.139905103235;24759.62860557057;24841.131146238895;25152;25176.74823251744 02:43:01 INFO - PROCESS | 15679 | |2;jquery.html;360.1680118925281;364.2514632430355;365.1000284299202;370.8145927036482;381.79955523350253;15904.443344482945;16607;17137.828621713812;17158.828411715895;17160.742588861176;15703.685926281467;16300.592485187875;17039.488815335528;17041.57396065099;17092.059936703477;4941.357623508939;5092.236164575306;5106.69359838409;5111.744412779365;5113.565346945496;3605.513255710485;3766.7928263945473;5074.644774865761;5459.590530710193;5748.712564371785;5683.062294721387;5695.829125126232;5710.343310519281;5720.0561907285455;5721.284839395075;5618.5786066045;5674.120511320752;5687.17535957286;5687.345955215162;5696.8860622787315;3261.72275356595;4754.762261886892;4855.854324370274;4978.327925730016;4989.126902792033;18378.540536486562;18987.145578448864;19026.52433689169;19108.904455477772;19208.423747287463;1945.0080458966029;1945.6692362298443;2154.633712268918;2224.154821167946;2297.1959814065112;12806.320960100475;12951;13034;13205.141665791789;13252.602421927357;1808.6111486030436;1871.822176893193;1876.6340563590106;1887.122488043053;1902.3436914264557;60694.696526517524;60746;62607;63435.391077578264;63989.36010639927;9160.22138118254;9164.312676549285;9251.629934802533;9736.367136136128;9909.157721593601;12865.742685146244;12909.99895016274;12941.935290323489;12942.547010854574;12949.352532373343;7011.475868687268;7043.119610048744;7302.087239095114;7403.592802395812;7426.962865185639;6935.653217339112;6991.685374158175;7006;7112.715491380287;7122.71509139639;5962.701864906738;6131.724072416752;6138.754449821957;6146.139540464339;6154.015357542861;1559.306108781604;1576.9211539423213;1666.2837277604087;1677.588990697287;1677.9244933978;915.8855143107112;917.2157805076697;961.3174646001418;972.4262685015875;1007.9244056695777;15614.21928903573;15985.680286394207;16850.157492125345;16893.408730694366;16894.98630082199;853.4921721575777;866.9176428239307;877.2236570635034;887.2813021452515;892.5983307511646;7340.743073992385;9870.21038316933;10000.099991000845;10028;10033.648822291185;363577;363939;377975;399488;401023;63254;63768.04347934692;65095.34904650987;65448.67275663591;67138.3286167132;966.7244835221928;972.3145182646359;1001.8497225416246;1011.7571782772081;1016.4460369098858;14986;15021.849781502046;15065.924670376578;15080.698386031998;15405.845941540441;30203;30579.847100764353;30656.846715766278;30835.69164308418;31029.8448507756;42189.78905105455;43058.27766889289;43058.78470607627;43226;43251.56748432601;7409.296116868889;7414.184439711736;7449.888251676338;7489.513181643176;7521.135069467081;6156.045812899008;8291.58542072906;11222.382768947786;11310;11375.943120284346;10172.949135254275;10192.235582331206;10239.948800256248;10560.84158737635;10916.290441121302;10051.095401413908;10186.694399168036;10204;10263.794724105626;10435.478226088513;10510.737231569272;10587.841182382424;10720;10821.134309255398;11050.834237486604;7258;7378.520396174232;7425.888611670721;7646.197149299243;7849.215078492105;9666.854997174907;10248.590056397661;10254.436006019441;10263.076323130954;10277.126444252022 02:43:01 INFO - PROCESS | 15679 | |3;mootools.html;1228.3428365824286;1436.6982933583943;1460.8100946876907;1594.3463180096155;1750.667373199092;7434.442416818733;7738.729144479944;7751.18612545683;7764.495307804996;7770.222977702241;7566.129895062069;7701.345385642213;7720.884186737189;7723.266289702469;7726.884096738553;1925.0759635375027;1986.3445063129134;1991.5021244688828;2211.2039665720285;2240.8655480671214;2233.9218127365543;2307.9307620771406;2315.490592069742;2317.8377513574055;2319.350581837088;2219.556088782242;2254.199759085526;2255.875926824024;2257.808086312665;2271.3980795089315;1918.673825449677;2156.579467003919;2228.565429741201;2229.3312006398014;2232.5758105959976;2220.7224096987875;2241.6301310283784;2245.5396643688005;2245.595792757303;2246.1352379334076;7633.427492937996;7665.501742386727;7681.039870016248;7689.115751688571;7691.307782299564;4380.912381752347;4499.235130027903;4527.61515271199;4538.841140560097;4546.363509108727;2822.350859302372;3053.969460305413;3058.770592205571;3065.20304720772;3067.1412004638737;966.1932286540747;975.0493269062678;978.4667356290838;992.8014397120605;996.6960077176458;10509.632162874263;10516.737081572945;10538.104261137813;10544.261901666887;10545.578176872916;4148.43996060534;4193.811278492475;4341.696081274281;4347.673924455678;4409;9127.315451341176;9128.58921348541;9166.12921772444;9171.633134674672;9173.770655733526;4560.087982403533;4563.155816174019;4597.44830620321;4601.7699115044115;4603.148417542765;3622.076370525499;3991.381335892941;4119.155573107506;4182.079942412664;4218.7679677618025;3665.7433979621705;3751.6998640109273;3804.2011177653003;3840.347140986039;3903.3559462688904;1196.7785959597502;1199.1605875886914;1214.690253985228;1217.4825699077855;1228.3919459867245;847.2036285891243;866.1554983890657;871.8169184471205;874.3966663002508;898.3397203055749;5262.315898933114;5316.291377502636;5340.664833791552;5485.424030476823;5487.835364939058;871.7297637732323;875.7329014650466;906.0893801729352;910.5811326789618;914.6752902719572;3687.483752274684;3741;3779.9433008504893;3796.772193668389;3823.9426408603895;8816.955915220382;9096.454212747256;9221.17009469151;9233.445993240428;9260.675876344296;9338.626454941726;9413.76465588352;9438.38650487716;9440.48077355752;9442.055794420641;7239.131304243525;7305.4155667546465;7349.963250183715;7350.77947661571;7374.815629609303;5279.577633789365;5344.706041167773;5351.117065684119;5403.648762830403;5572.498475137257;8690.565471726262;8722.651093956425;8830.867536987078;8893.28853691716;8994.595243214202;8717.564121794012;8852.513111778657;8976.685815996409;8995.505247211204;8999.505027223566;5714.085746280742;5884.499817515559;5887.411258874078;6341.8097457076365;6490.740370385131;6564.081028656087;6590.1103351046995;6636.469082473487;7498.812529686801;7503.437242206747;6653.467722582279;6687.130673012672;6735.562188457735;6767.627780471925;6785.219699734594;6649.534532582673;6672.432843208382;6684.231313398827;6744.954532047541;6845.486588505982;6328.746850125944;6339.144215530844;6366.6180029198395;6370.490360771035;6388.456981156468;4529.071540334289;4641.443026836666;4658.534146585314;4722.456917454399;4737.810487580596;4446.777661116996;4483.484399294123;4548.181327360974;4557.749323787223;4613.284940834176 02:43:01 INFO - PROCESS | 15679 | |4;prototype.html;301.5627340356483;308.63580974450156;310.7296651912836;313.21383327847127;315.09410444970695;5063.088644044071;5092.719900405481;5093.79624815007;5105.157648987913;5117.130087885059;4998.525140111684;5018;5028.84913452597;5040.3951525816865;5049.747512624373;3735.2716220337047;3803.543574771031;3855.7108216883707;3952.861649842256;3964.1278918638;3903.750799744083;3956.6834653227816;3964.0882597002706;3976.383660532622;3976.403539469074;3707.536557930259;3914.9233960660763;3918.373060310351;3926.5877082906313;3944.3886197639413;3783.81080945953;3865.439511270878;3865.632764887331;3891.416287556861;3920.470736450571;3464.4110501214855;3465.151037995682;3469.421413256962;3469.444888817802;3471.1669199392218;4838.443578988391;4848.418189817209;4862.5623693867365;4871.29366241893;4890.5109489051165;4214.957850421518;4467.463904331468;4475.70907890986;4510.458744950594;4529.773511324421;5272.393674727417;5276.707206734336;5290.841274761725;5296.549793267577;5300.204969254604;3712.2204337088974;3720.9069773255887;3723.255348930225;3724.1062145085257;3724.404095344732;5237.319148510707;5525.723713814334;5561.860953476155;5589.972050139764;5597.412271711493;3762.1347090169415;3764.8682296119505;3767.416050512175;3777.0934975605655;3805.06775839921;3842.442845787345;3845.942310865339;3849.5188101487315;3852.8651497197466;3853.421986701961;4262.825958761055;4424.424824772759;4433.889152771142;4440.977795111004;4444.933326000112;5300.390455097636;5321.36143662763;5321.813736519203;5322.654027488201;5341;1320.6830360713552;1342.2952849880596;1343.6909510812372;1344.6503908983734;1347.2253454263837;839.1650307943635;878.2578720980761;886.8315020146151;904.1004200820227;904.6788390121544;4690.202665546865;4709.67032307742;4715.104130215248;4725.267583524559;4733.715977041388;5419.160030195326;5429.212764149176;5435.402105768362;5446.891062178814;5459.8362049137795;4448.5551444855255;4641.512641172628;4708.387909571734;4717.764111794397;4726.480087190406;2900.7374248086526;2927.458420192271;2941.294089418524;2946.5138252188576;2954.5863579098946;5212.270282160501;5239.659422137549;5241.633085684041;5247.63266571344;5252.632315737938;5469.699166545878;5616.213730077792;5655.144152203194;5655.802046928337;5668.348139963874;5197.376314842168;5209.843704688866;5214.243934629458;5229.738513074255;5232.476752324813;5472.781088756406;5497.780088796563;5501.394846566955;5503.834884953458;5506.339239291311;5155.917257375843;5390.51485366319;5392.031908353501;5407.648502847303;5414.75633596497;5212.661177023633;5226.216067589892;5246.790128394821;5253.106971814725;5257.763400647056;3812.6759225466144;3822.7515211511163;3839.2321535692413;3843.8846834595006;3851.2490064437166;5245.868853278546;5483.095289277225;5520.1167813149705;5537.307836520435;5553.888922221452;5343.4389389113585;5343.7595308212;5363.222332761806;5369.865753356197;5379.606075296456;5193.117170081171;5328.413874473727;5331.120365139708;5371.5702743781185;5393.946060539344;4987.600991920565;5267.446918073547;5276.182191760283;5276.81531146408;5294.152935530296;5196.959778529603;5379.596530260168;5386.192071189353;5392.811251606175;5410.8647283816645;5194.870128246824;5234.528892399702;5276.15581506957;5290.867728306823;5296.629235953446 02:43:01 INFO - PROCESS | 15679 | |5;yui.html;690.9723611055557;788.3968763895624;800.4716886854677;805.5730462854689;807.1283014344508;11392.544298228071;11635.534578616865;11657.475413606388;11679.941600291997;11728.53085876565;12044.939775301133;12131.02951763859;12142.150049496538;12160.817587736192;12236.938815305912;621.139721485741;759.8594260061878;783.2793829676683;787.094840932926;790.5572879187645;787.6888628991545;796.5260669901428;796.5778137587088;796.7330944133722;799.6801279488222;837.9916200837974;840.6595328891808;844.6579135450122;844.8690452979768;844.9028361738386;632.3644737039292;824.3281725393784;845.4631309118693;847.3433089355736;848.804774901776;612.7395856760859;616.5653214483823;619.7706848466051;620.1751670278563;620.509797260164;11708.648740537797;11730.296182229009;11747.588834390755;11750.529978800838;11768.235064720851;12339.444724987397;12782.296973666445;12977.610671679864;13112.409941552558;13179.934100329532;9198.126178013077;9607;9618.90381096187;9753.512324383822;9834.704958851245;4031.3751368537924;4101.343784994387;4148.336266197424;4149;4149.668026557898;46579.53420465786;47152.29271560929;47348.76325618384;47479.287810683214;47787.28319075217;9644.276679248944;9976.650817221362;10088.243381746399;10095.495225238856;10335.069843714102;15935.36258549645;16110.436134735228;16203.675926481405;16206.59483512898;16219.918900405422;6392.6849774389975;6544.443722283564;6638.20341559016;6690.632015239208;6973.163220413583;3897.4933258676756;3937.114149316381;3967.713218582285;3974.980125099356;4097.323941549671;2866.1115054333222;2915.985420072886;2918.1829087855435;2919.4161167766533;2921.547160190174;509.84194899581246;510.57112025898425;521.6687403498805;522.7934965688607;524.4860037163601;570.3099249907658;598.61090291311;601.7232073246269;620.1380081686459;660.9008648702733;7719.382449404035;7792.454528183086;7792.532448053135;7838.647260873275;8098.797530061795;619.7335145887222;639.9040143978348;640.3436477610394;647.346180357842;653.9247986481521;3737.9626203738158;3775.5469343678383;3821.904452388657;3856.325143099946;3920.4315374270573;51031.744841275555;53065;53258.73370633122;53264.73367633137;53268.733656332246;38119;40481.1903761929;44443.111137777065;46414;46642.766786165856;35415;35719.4642080369;35920.46119308213;39289.21421571496;40073.59926400757;7979.202079791974;8147.877781833158;8382;8416.705415310435;8439.324854011787;26716.19851404461;27148.864255678596;27288.863555682095;27331.86334068317;27350.72649273482;32200.516992244666;33983.49024764581;34640.653593464755;37242.8137859309;38488.422673659355;10553.208509361983;10621.203409744145;10758.946205269236;10939.835902461311;11028.28316159447;11699.23954942926;11757.647270581896;11880.76238475243;12157.939210303892;12518.37408129608;11042.558297668003;11173.994340509393;11546.979278626039;11969.222000569935;11969.521219151136;11561.653150405502;11787.057035437316;12175.452104655134;12378.381080946097;12438.564650237198;11175.664730058112;11348.092152627605;11789.351585662871;12053.397330133283;12074.879251207376;9771.364861283993;10075.193984481077;10254.53854576531;10369.896301036893;10401.895981040092;9216.631334746535;9352.953235233781;9797.31418800677;9829.852552211865;9859.802803944025 02:43:01 INFO - PROCESS | 15679 | __end_tp_report 02:43:01 INFO - PROCESS | 15679 | __start_cc_report 02:43:01 INFO - PROCESS | 15679 | _x_x_mozilla_cycle_collect,1016 02:43:01 INFO - PROCESS | 15679 | __end_cc_report 02:43:01 INFO - PROCESS | 15679 | __startTimestamp1461231781588__endTimestamp 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | ------- Summary: start ------- 02:43:01 INFO - PROCESS | 15679 | Number of tests: 6 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#0] dojo.html Cycles:165 Average:4572.43 Median:4737.43 stddev:474.54 (10.0%) stddev-sans-first:448.93 02:43:01 INFO - PROCESS | 15679 | Values: 2558.9 2642.0 2648.8 2667.4 2686.3 4529.8 4572.0 4653.8 4680.2 4695.1 4623.4 4653.4 4689.0 4694.8 4707.6 4192.7 4206.6 4214.0 4280.7 4387.4 4325.2 4377.6 4407.4 4416.3 4433.4 4134.2 4179.9 4196.5 4316.7 4331.3 4216.6 4221.9 4221.9 4223.2 4251.9 4190.7 4218.3 4221.3 4234.2 4258.1 4522.7 4530.6 4532.1 4542.7 4587.0 4833.1 4874.6 4944.5 4944.9 4966.5 4965.8 4969.5 4971.8 4972.2 5004.3 4625.4 4637.5 4640.2 4640.5 4645.3 4882.5 5056.4 5073.8 5134.4 5160.5 4844.4 4862.3 4863.8 4870.3 4915.4 4945.2 4946.1 4956.0 4957.5 4994.0 4755.6 4944.3 4972.2 5029.9 5031.9 4852.4 4871.8 4878.1 4878.7 4931.1 4002.7 4077.1 4089.3 4095.4 4129.8 3616.0 3622.0 3624.2 3669.1 3718.7 4221.2 4246.2 4254.7 4273.0 4285.4 4705.5 4813.4 4842.0 4850.7 4895.9 4245.6 4281.2 4300.0 4323.8 4342.0 4443.7 4453.6 4461.5 4499.1 4503.2 4519.2 4665.4 4743.9 4744.0 4751.7 4988.0 4993.9 5000.4 5001.6 5052.0 4723.1 4771.5 4774.7 4789.8 4827.1 4747.7 4801.1 4869.7 4941.7 4985.5 4914.1 4924.2 4930.1 4931.1 4980.2 4785.4 4789.5 4803.6 4851.3 4851.5 4703.8 4762.5 4769.8 4859.4 4875.2 4745.1 4754.0 4757.1 4761.3 4785.7 4864.9 4870.9 4872.6 4873.8 4919.9 4582.4 4664.5 4737.4 4786.9 4844.7 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#1] ext.html Cycles:180 Average:46157.76 Median:34441.57 stddev:80331.71 (233.2%) stddev-sans-first:80484.09 02:43:01 INFO - PROCESS | 15679 | Values: 554.7 594.5 595.3 598.3 598.7 33586.7 34668.5 34672.5 34706.5 34734.3 36274.0 37036.8 37073.0 37258.6 37299.3 7254.7 7322.5 7380.4 7381.6 7777.1 7363.9 9662.9 10052.1 10065.7 10067.0 9712.0 9792.9 9817.4 9821.7 9823.2 7670.7 7943.3 9577.1 9696.7 9705.2 7579.8 9453.9 9716.5 9725.0 9733.9 34833.1 35528.3 35553.3 35661.5 35698.5 3097.1 3209.1 3354.9 3402.1 3553.8 28863.7 29382.7 29854.1 30527.2 30830.2 3429.7 3452.3 3496.9 3517.7 3530.8 292413.0 299954.0 300428.0 300665.0 301510.0 57044.4 57512.1 57804.4 58028.7 58058.0 60742.4 61834.0 63216.0 65106.7 65306.7 12175.6 12180.9 12192.9 12202.9 12209.2 9978.5 10726.0 11070.5 11207.9 11331.5 18215.7 18326.5 18335.4 18434.2 18435.6 6886.0 7110.9 7348.5 7361.3 7409.4 908.2 943.6 960.0 965.6 980.5 27401.0 28792.4 29018.3 31576.7 32148.4 1012.4 1025.6 1037.6 1060.7 1062.8 14307.9 14839.9 14970.4 15043.2 15121.8 332250.0 339125.0 339126.0 339553.0 340219.0 48504.5 49391.3 49435.0 49453.8 49510.3 1106.8 1108.9 1166.6 1265.0 1271.1 25104.2 26007.2 26029.6 26242.9 28309.3 41411.0 41903.4 42227.2 42366.4 42413.8 277173.0 277436.0 279281.0 279842.0 280080.0 21924.9 25589.4 25633.1 26224.1 26255.7 36134.9 36232.1 39020.6 39319.6 39327.0 33464.0 33528.3 33894.5 34466.8 34795.7 32914.8 34216.7 34594.3 34723.7 35046.3 34032.8 34109.8 34416.3 34796.1 34858.7 30145.5 30973.3 31187.8 31302.0 31385.0 24574.1 24759.6 24841.1 25152.0 25176.7 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#2] jquery.html Cycles:180 Average:23109.87 Median:367.96 stddev:62558.91 (17001.7%) stddev-sans-first:62711.09 02:43:01 INFO - PROCESS | 15679 | Values: 360.2 364.3 365.1 370.8 381.8 15904.4 16607.0 17137.8 17158.8 17160.7 15703.7 16300.6 17039.5 17041.6 17092.1 4941.4 5092.2 5106.7 5111.7 5113.6 3605.5 3766.8 5074.6 5459.6 5748.7 5683.1 5695.8 5710.3 5720.1 5721.3 5618.6 5674.1 5687.2 5687.3 5696.9 3261.7 4754.8 4855.9 4978.3 4989.1 18378.5 18987.1 19026.5 19108.9 19208.4 1945.0 1945.7 2154.6 2224.2 2297.2 12806.3 12951.0 13034.0 13205.1 13252.6 1808.6 1871.8 1876.6 1887.1 1902.3 60694.7 60746.0 62607.0 63435.4 63989.4 9160.2 9164.3 9251.6 9736.4 9909.2 12865.7 12910.0 12941.9 12942.5 12949.4 7011.5 7043.1 7302.1 7403.6 7427.0 6935.7 6991.7 7006.0 7112.7 7122.7 5962.7 6131.7 6138.8 6146.1 6154.0 1559.3 1576.9 1666.3 1677.6 1677.9 915.9 917.2 961.3 972.4 1007.9 15614.2 15985.7 16850.2 16893.4 16895.0 853.5 866.9 877.2 887.3 892.6 7340.7 9870.2 10000.1 10028.0 10033.6 363577.0 363939.0 377975.0 399488.0 401023.0 63254.0 63768.0 65095.3 65448.7 67138.3 966.7 972.3 1001.8 1011.8 1016.4 14986.0 15021.8 15065.9 15080.7 15405.8 30203.0 30579.8 30656.8 30835.7 31029.8 42189.8 43058.3 43058.8 43226.0 43251.6 7409.3 7414.2 7449.9 7489.5 7521.1 6156.0 8291.6 11222.4 11310.0 11375.9 10172.9 10192.2 10239.9 10560.8 10916.3 10051.1 10186.7 10204.0 10263.8 10435.5 10510.7 10587.8 10720.0 10821.1 11050.8 7258.0 7378.5 7425.9 7646.2 7849.2 9666.9 10248.6 10254.4 10263.1 10277.1 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#3] mootools.html Cycles:180 Average:5098.84 Median:5377.38 stddev:2794.07 (52.0%) stddev-sans-first:2786.76 02:43:01 INFO - PROCESS | 15679 | Values: 1228.3 1436.7 1460.8 1594.3 1750.7 7434.4 7738.7 7751.2 7764.5 7770.2 7566.1 7701.3 7720.9 7723.3 7726.9 1925.1 1986.3 1991.5 2211.2 2240.9 2233.9 2307.9 2315.5 2317.8 2319.4 2219.6 2254.2 2255.9 2257.8 2271.4 1918.7 2156.6 2228.6 2229.3 2232.6 2220.7 2241.6 2245.5 2245.6 2246.1 7633.4 7665.5 7681.0 7689.1 7691.3 4380.9 4499.2 4527.6 4538.8 4546.4 2822.4 3054.0 3058.8 3065.2 3067.1 966.2 975.0 978.5 992.8 996.7 10509.6 10516.7 10538.1 10544.3 10545.6 4148.4 4193.8 4341.7 4347.7 4409.0 9127.3 9128.6 9166.1 9171.6 9173.8 4560.1 4563.2 4597.4 4601.8 4603.1 3622.1 3991.4 4119.2 4182.1 4218.8 3665.7 3751.7 3804.2 3840.3 3903.4 1196.8 1199.2 1214.7 1217.5 1228.4 847.2 866.2 871.8 874.4 898.3 5262.3 5316.3 5340.7 5485.4 5487.8 871.7 875.7 906.1 910.6 914.7 3687.5 3741.0 3779.9 3796.8 3823.9 8817.0 9096.5 9221.2 9233.4 9260.7 9338.6 9413.8 9438.4 9440.5 9442.1 7239.1 7305.4 7350.0 7350.8 7374.8 5279.6 5344.7 5351.1 5403.6 5572.5 8690.6 8722.7 8830.9 8893.3 8994.6 8717.6 8852.5 8976.7 8995.5 8999.5 5714.1 5884.5 5887.4 6341.8 6490.7 6564.1 6590.1 6636.5 7498.8 7503.4 6653.5 6687.1 6735.6 6767.6 6785.2 6649.5 6672.4 6684.2 6745.0 6845.5 6328.7 6339.1 6366.6 6370.5 6388.5 4529.1 4641.4 4658.5 4722.5 4737.8 4446.8 4483.5 4548.2 4557.7 4613.3 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#4] prototype.html Cycles:180 Average:4404.35 Median:5056.42 stddev:1296.69 (25.6%) stddev-sans-first:1263.23 02:43:01 INFO - PROCESS | 15679 | Values: 301.6 308.6 310.7 313.2 315.1 5063.1 5092.7 5093.8 5105.2 5117.1 4998.5 5018.0 5028.8 5040.4 5049.7 3735.3 3803.5 3855.7 3952.9 3964.1 3903.8 3956.7 3964.1 3976.4 3976.4 3707.5 3914.9 3918.4 3926.6 3944.4 3783.8 3865.4 3865.6 3891.4 3920.5 3464.4 3465.2 3469.4 3469.4 3471.2 4838.4 4848.4 4862.6 4871.3 4890.5 4215.0 4467.5 4475.7 4510.5 4529.8 5272.4 5276.7 5290.8 5296.5 5300.2 3712.2 3720.9 3723.3 3724.1 3724.4 5237.3 5525.7 5561.9 5590.0 5597.4 3762.1 3764.9 3767.4 3777.1 3805.1 3842.4 3845.9 3849.5 3852.9 3853.4 4262.8 4424.4 4433.9 4441.0 4444.9 5300.4 5321.4 5321.8 5322.7 5341.0 1320.7 1342.3 1343.7 1344.7 1347.2 839.2 878.3 886.8 904.1 904.7 4690.2 4709.7 4715.1 4725.3 4733.7 5419.2 5429.2 5435.4 5446.9 5459.8 4448.6 4641.5 4708.4 4717.8 4726.5 2900.7 2927.5 2941.3 2946.5 2954.6 5212.3 5239.7 5241.6 5247.6 5252.6 5469.7 5616.2 5655.1 5655.8 5668.3 5197.4 5209.8 5214.2 5229.7 5232.5 5472.8 5497.8 5501.4 5503.8 5506.3 5155.9 5390.5 5392.0 5407.6 5414.8 5212.7 5226.2 5246.8 5253.1 5257.8 3812.7 3822.8 3839.2 3843.9 3851.2 5245.9 5483.1 5520.1 5537.3 5553.9 5343.4 5343.8 5363.2 5369.9 5379.6 5193.1 5328.4 5331.1 5371.6 5393.9 4987.6 5267.4 5276.2 5276.8 5294.2 5197.0 5379.6 5386.2 5392.8 5410.9 5194.9 5234.5 5276.2 5290.9 5296.6 02:43:01 INFO - PROCESS | 15679 | 02:43:01 INFO - PROCESS | 15679 | [#5] yui.html Cycles:180 Average:12471.78 Median:4124.84 stddev:13813.58 (334.9%) stddev-sans-first:13823.99 02:43:01 INFO - PROCESS | 15679 | Values: 691.0 788.4 800.5 805.6 807.1 11392.5 11635.5 11657.5 11679.9 11728.5 12044.9 12131.0 12142.2 12160.8 12236.9 621.1 759.9 783.3 787.1 790.6 787.7 796.5 796.6 796.7 799.7 838.0 840.7 844.7 844.9 844.9 632.4 824.3 845.5 847.3 848.8 612.7 616.6 619.8 620.2 620.5 11708.6 11730.3 11747.6 11750.5 11768.2 12339.4 12782.3 12977.6 13112.4 13179.9 9198.1 9607.0 9618.9 9753.5 9834.7 4031.4 4101.3 4148.3 4149.0 4149.7 46579.5 47152.3 47348.8 47479.3 47787.3 9644.3 9976.7 10088.2 10095.5 10335.1 15935.4 16110.4 16203.7 16206.6 16219.9 6392.7 6544.4 6638.2 6690.6 6973.2 3897.5 3937.1 3967.7 3975.0 4097.3 2866.1 2916.0 2918.2 2919.4 2921.5 509.8 510.6 521.7 522.8 524.5 570.3 598.6 601.7 620.1 660.9 7719.4 7792.5 7792.5 7838.6 8098.8 619.7 639.9 640.3 647.3 653.9 3738.0 3775.5 3821.9 3856.3 3920.4 51031.7 53065.0 53258.7 53264.7 53268.7 38119.0 40481.2 44443.1 46414.0 46642.8 35415.0 35719.5 35920.5 39289.2 40073.6 7979.2 8147.9 8382.0 8416.7 8439.3 26716.2 27148.9 27288.9 27331.9 27350.7 32200.5 33983.5 34640.7 37242.8 38488.4 10553.2 10621.2 10758.9 10939.8 11028.3 11699.2 11757.6 11880.8 12157.9 12518.4 11042.6 11174.0 11547.0 11969.2 11969.5 11561.7 11787.1 12175.5 12378.4 12438.6 11175.7 11348.1 11789.4 12053.4 12074.9 9771.4 10075.2 10254.5 10369.9 10401.9 9216.6 9353.0 9797.3 9829.9 9859.8 02:43:01 INFO - PROCESS | 15679 | -------- Summary: end -------- 02:43:01 INFO - PROCESS | 15679 | 02:43:02 INFO - TEST-INFO | 15679: exit 0 02:43:02 INFO - TEST-OK | dromaeo_css | took 1119409ms 02:43:02 INFO - TEST-START | kraken 02:43:02 INFO - operating with platform_type : linux_ 02:43:02 INFO - Initialising browser for kraken test... 02:43:02 INFO - TEST-INFO | started process 15856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyn3gI0/profile http://localhost:43377/getInfo.html) 02:43:06 INFO - PROCESS | 15856 | __metrics Screen width/height:1600/1200 02:43:06 INFO - PROCESS | 15856 | colorDepth:24 02:43:06 INFO - PROCESS | 15856 | Browser inner width/height: 1024/697 02:43:06 INFO - PROCESS | 15856 | __metrics 02:43:07 ERROR - PROCESS | 15856 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:43:08 INFO - TEST-INFO | 15856: exit 0 02:43:08 INFO - Browser initialized. 02:43:08 INFO - Running cycle 1/1 for kraken test... 02:43:08 INFO - TEST-INFO | started process 15940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyn3gI0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:20 INFO - PROCESS | 15940 | RSS: Main: 154783744 02:43:20 INFO - PROCESS | 15940 | 02:43:22 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:23 INFO - PROCESS | 15940 | RSS: Main: 210341888 02:43:23 INFO - PROCESS | 15940 | 02:43:26 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-dft) 02:43:27 INFO - PROCESS | 15940 | RSS: Main: 195514368 02:43:27 INFO - PROCESS | 15940 | 02:43:30 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-fft) 02:43:31 INFO - PROCESS | 15940 | RSS: Main: 266657792 02:43:31 INFO - PROCESS | 15940 | 02:43:33 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-oscillator) 02:43:33 INFO - PROCESS | 15940 | RSS: Main: 173789184 02:43:33 INFO - PROCESS | 15940 | 02:43:36 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:36 INFO - PROCESS | 15940 | RSS: Main: 179019776 02:43:36 INFO - PROCESS | 15940 | 02:43:39 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:40 INFO - PROCESS | 15940 | RSS: Main: 214728704 02:43:40 INFO - PROCESS | 15940 | 02:43:43 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:44 INFO - PROCESS | 15940 | RSS: Main: 215547904 02:43:44 INFO - PROCESS | 15940 | 02:43:47 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43377/tests/kraken/driver.html?testName=json-parse-financial) 02:43:48 INFO - PROCESS | 15940 | RSS: Main: 216006656 02:43:48 INFO - PROCESS | 15940 | 02:43:49 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:50 INFO - PROCESS | 15940 | RSS: Main: 202702848 02:43:50 INFO - PROCESS | 15940 | 02:43:52 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:52 INFO - PROCESS | 15940 | RSS: Main: 205344768 02:43:52 INFO - PROCESS | 15940 | 02:43:54 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:55 INFO - PROCESS | 15940 | RSS: Main: 218521600 02:43:55 INFO - PROCESS | 15940 | 02:43:58 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:59 INFO - PROCESS | 15940 | RSS: Main: 220205056 02:43:59 INFO - PROCESS | 15940 | 02:44:02 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:02 INFO - PROCESS | 15940 | RSS: Main: 220123136 02:44:02 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43377/tests/kraken/driver.html?testName=ai-astar) 02:44:04 INFO - PROCESS | 15940 | RSS: Main: 282841088 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | __start_tp_report 02:44:04 INFO - PROCESS | 15940 | _x_x_mozilla_page_load 02:44:04 INFO - PROCESS | 15940 | _x_x_mozilla_page_load_details 02:44:04 INFO - PROCESS | 15940 | |i|pagename|runs| 02:44:04 INFO - PROCESS | 15940 | |0;ai-astar;112;114;111;113;115;114;100;113;113;113 02:44:04 INFO - PROCESS | 15940 | |1;audio-beat-detection;166;137;159;189;133;158;159;137;187;130 02:44:04 INFO - PROCESS | 15940 | |2;audio-dft;162;160;161;160;163;162;161;162;161;161 02:44:04 INFO - PROCESS | 15940 | |3;audio-fft;75;74;105;122;75;74;77;119;100;76 02:44:04 INFO - PROCESS | 15940 | |4;audio-oscillator;95;95;134;94;95;94;143;95;95;147 02:44:04 INFO - PROCESS | 15940 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;117;117;117 02:44:04 INFO - PROCESS | 15940 | |6;imaging-darkroom;147;145;146;146;145;146;146;147;146;145 02:44:04 INFO - PROCESS | 15940 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;95;95 02:44:04 INFO - PROCESS | 15940 | |8;json-parse-financial;64;64;64;64;64;63;64;93;63;63 02:44:04 INFO - PROCESS | 15940 | |9;json-stringify-tinderbox;64;63;63;64;65;64;63;65;64;65 02:44:04 INFO - PROCESS | 15940 | |10;stanford-crypto-aes;79;80;79;86;87;80;81;80;85;80 02:44:04 INFO - PROCESS | 15940 | |11;stanford-crypto-ccm;134;135;136;141;132;136;132;142;214;145 02:44:04 INFO - PROCESS | 15940 | |12;stanford-crypto-pbkdf2;175;176;174;176;173;175;175;178;179;175 02:44:04 INFO - PROCESS | 15940 | |13;stanford-crypto-sha256-iterative;74;73;74;74;72;72;74;73;74;75 02:44:04 INFO - PROCESS | 15940 | __end_tp_report 02:44:04 INFO - PROCESS | 15940 | __start_cc_report 02:44:04 INFO - PROCESS | 15940 | _x_x_mozilla_cycle_collect,1896 02:44:04 INFO - PROCESS | 15940 | __end_cc_report 02:44:04 INFO - PROCESS | 15940 | __startTimestamp1461231844774__endTimestamp 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | ------- Summary: start ------- 02:44:04 INFO - PROCESS | 15940 | Number of tests: 14 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.29 (3.8%) stddev-sans-first:4.55 02:44:04 INFO - PROCESS | 15940 | Values: 112.0 114.0 111.0 113.0 115.0 114.0 100.0 113.0 113.0 113.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:159.00 stddev:21.33 (13.4%) stddev-sans-first:22.29 02:44:04 INFO - PROCESS | 15940 | Values: 166.0 137.0 159.0 189.0 133.0 158.0 159.0 137.0 187.0 130.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:44:04 INFO - PROCESS | 15940 | Values: 162.0 160.0 161.0 160.0 163.0 162.0 161.0 162.0 161.0 161.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#3] audio-fft Cycles:10 Average:89.70 Median:74.50 stddev:19.77 (26.5%) stddev-sans-first:20.24 02:44:04 INFO - PROCESS | 15940 | Values: 75.0 74.0 105.0 122.0 75.0 74.0 77.0 119.0 100.0 76.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:22.74 (23.9%) stddev-sans-first:23.57 02:44:04 INFO - PROCESS | 15940 | Values: 95.0 95.0 134.0 94.0 95.0 94.0 143.0 95.0 95.0 147.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:44:04 INFO - PROCESS | 15940 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 02:44:04 INFO - PROCESS | 15940 | Values: 147.0 145.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 145.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:44:04 INFO - PROCESS | 15940 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:64.00 stddev:9.29 (14.5%) stddev-sans-first:9.80 02:44:04 INFO - PROCESS | 15940 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 93.0 63.0 63.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 02:44:04 INFO - PROCESS | 15940 | Values: 64.0 63.0 63.0 64.0 65.0 64.0 63.0 65.0 64.0 65.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.50 stddev:3.06 (3.8%) stddev-sans-first:3.08 02:44:04 INFO - PROCESS | 15940 | Values: 79.0 80.0 79.0 86.0 87.0 80.0 81.0 80.0 85.0 80.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:138.50 stddev:24.73 (17.9%) stddev-sans-first:25.93 02:44:04 INFO - PROCESS | 15940 | Values: 134.0 135.0 136.0 141.0 132.0 136.0 132.0 142.0 214.0 145.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.50 stddev:1.78 (1.0%) stddev-sans-first:1.87 02:44:04 INFO - PROCESS | 15940 | Values: 175.0 176.0 174.0 176.0 173.0 175.0 175.0 178.0 179.0 175.0 02:44:04 INFO - PROCESS | 15940 | 02:44:04 INFO - PROCESS | 15940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 02:44:04 INFO - PROCESS | 15940 | Values: 74.0 73.0 74.0 74.0 72.0 72.0 74.0 73.0 74.0 75.0 02:44:04 INFO - PROCESS | 15940 | -------- Summary: end -------- 02:44:04 INFO - PROCESS | 15940 | 02:44:05 INFO - TEST-INFO | 15940: exit 0 02:44:05 INFO - TEST-OK | kraken | took 63469ms 02:44:05 INFO - SUITE-END | took 1182s 02:44:05 INFO - Completed test suite (00:19:42) 02:44:05 INFO - javascript benchmark 02:44:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.8868842053703, 2642.035656985199, 2648.7616114549687, 2667.439837634097, 2686.3149896776326, 4529.818807247714, 4572.017016341486, 4653.790579423926, 4680.227762419201, 4695.131400690874, 4623.42207224097, 4653.395058642372, 4688.991866748648, 4694.812207511695, 4707.576318131368, 4192.7484350938885, 4206.600372964564, 4213.978930105345, 4280.74315541067, 4387.4296341475565, 4325.243082460573, 4377.627901628365, 4407.427034485512, 4416.293393057112, 4433.401490798733, 4134.193832202722, 4179.874603761892, 4196.538380778112, 4316.676249281317, 4331.32864406016, 4216.57834216579, 4221.852235171754, 4221.873343799691, 4223.155368926196, 4251.893702657428, 4190.706650534464, 4218.34615634574, 4221.282381995037, 4234.216669916075, 4258.105797782469, 4522.66080043998, 4530.569595888385, 4532.116237333721, 4542.70472419295, 4586.977065114653, 4833.081714474239, 4874.585660218886, 4944.505549445063, 4944.851654450372, 4966.453690094087, 4965.826196083156, 4969.478204788517, 4971.776270067856, 4972.179590367585, 5004.324416203839, 4625.444946606395, 4637.46669133054, 4640.187967105777, 4640.512746161672, 4645.349651048856, 4882.487338829443, 5056.393232812086, 5073.797048118034, 5134.409542902614, 5160.458151894072, 4844.418669759581, 4862.270659401118, 4863.829765958245, 4870.342503762017, 4915.361003069578, 4945.208766597327, 4946.109700253917, 4955.98402327522, 4957.479464656231, 4994.026164897883, 4755.595774359218, 4944.258361245842, 4972.229304457815, 5029.924551131736, 5031.874203144951, 4852.393450818648, 4871.8294859679745, 4878.07316609843, 4878.731669758126, 4931.112399768076, 4002.7198096133575, 4077.103037331782, 4089.3048181809163, 4095.385692146202, 4129.772862492592, 3616.023673608111, 3621.9637803622154, 3624.2026754114054, 3669.1377526281303, 3718.7025037996896, 4221.197972385237, 4246.150769846043, 4254.659627229814, 4272.978635106804, 4285.442892424027, 4705.529447055267, 4813.446453657804, 4841.975790121027, 4850.660453768202, 4895.877603059881, 4245.575442455792, 4281.165172791276, 4299.9785001075425, 4323.762193079411, 4342.044750154961, 4443.688941774045, 4453.643708503312, 4461.5092339842595, 4499.0776890737325, 4503.211937910918, 4519.209138400833, 4665.440147182224, 4743.857684269408, 4744.0, 4751.667383283137, 4987.950120498748, 4993.900121997613, 5000.449950505515, 5001.624878134082, 5052.0, 4723.102610503994, 4771.475137734777, 4774.665773395829, 4789.7605119743175, 4827.106985207748, 4747.715137091785, 4801.135795556834, 4869.683470574401, 4941.65408421407, 4985.451600323889, 4914.115459217375, 4924.187509060965, 4930.087933732271, 4931.0630980113665, 4980.153373926513, 4785.353977213032, 4789.473157952692, 4803.567678908915, 4851.2723091535145, 4851.490593487633, 4703.788329525248, 4762.547557981986, 4769.785359658755, 4859.441164266154, 4875.195592727302, 4745.1221524018165, 4754.0, 4757.14371413149, 4761.262004389325, 4785.688930219525, 4864.902701946012, 4870.878228044327, 4872.610191184625, 4873.756312184306, 4919.901601967869, 4582.381378513858, 4664.510226426177, 4737.431508219036, 4786.856394308176, 4844.733539655353], "value": 4542.84854858341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7309554865892, 594.5332913662776, 595.3362001368473, 598.3478008970221, 598.6677394046304, 33586.66413335869, 34668.47997280036, 34672.479912801326, 34706.479402808945, 34734.30531389374, 36274.0, 37036.81481592595, 37073.0, 37258.62741372585, 37299.25401491969, 7254.673539690701, 7322.48742588019, 7380.409567234635, 7381.630918454082, 7777.10563285221, 7363.889541656879, 9662.855057174149, 10052.14556762676, 10065.698029059104, 10067.0, 9711.951440242825, 9792.853107203362, 9817.410955342666, 9821.65624203153, 9823.165030972375, 7670.654820533034, 7943.324817390529, 9577.090176433228, 9696.660616878446, 9705.223582113449, 7579.772606821749, 9453.858192127123, 9716.514174291327, 9725.0, 9733.90266097337, 34833.129171770655, 35528.28943421143, 35553.28893422143, 35661.46507802385, 35698.464523031915, 3097.132802815215, 3209.1495753625077, 3354.9496757548654, 3402.1494626343415, 3553.7690050146657, 28863.711362886523, 29382.706172938426, 29854.122242372254, 30527.236819079477, 30830.229244269074, 3429.725621950263, 3452.2577645806273, 3496.8950931472095, 3517.736169787276, 3530.841112149934, 292413.0, 299954.0, 300428.0, 300665.0, 301510.0, 57044.429555704744, 57512.13731793943, 57804.4219557799, 58028.70985645129, 58058.0, 60742.392576073675, 61834.0, 63216.0, 65106.674466627366, 65306.67346663236, 12175.573854915036, 12180.878191218151, 12192.939035304767, 12202.877971220352, 12209.206401583868, 9978.451185184884, 10726.0, 11070.501827417786, 11207.887921120848, 11331.546738130382, 18215.72676409855, 18326.541836454195, 18335.449936501926, 18434.170462329228, 18435.631287374177, 6886.0, 7110.92889071113, 7348.52234604749, 7361.2638736125955, 7409.407247420193, 908.1871724806261, 943.5895385507326, 959.9776238306182, 965.5992763003275, 980.4852452462371, 27401.0, 28792.42415151685, 29018.27454313659, 31576.684233157834, 32148.35703285921, 1012.4229189361993, 1025.6410256410345, 1037.6057098302747, 1060.7454210989306, 1062.829947208443, 14307.92846035763, 14839.851601484062, 14970.401183952737, 15043.194816622075, 15121.848781512264, 332250.0, 339125.0, 339126.0, 339553.0, 340219.0, 48504.5149548507, 49391.25913111306, 49435.0, 49453.75273123611, 49510.257346139835, 1106.7952428800697, 1108.922375433712, 1166.5683697032152, 1264.9557265495664, 1271.1165739810742, 25104.246872593852, 26007.219783406526, 26029.6095558563, 26242.868785655948, 28309.29226769265, 41411.0, 41903.37144942767, 42227.155456890076, 42366.36450453184, 42413.78793106015, 277173.0, 277436.0, 279281.0, 279842.0, 280080.0, 21924.890375548657, 25589.3602659935, 25633.10284140046, 26224.08215712441, 26255.73744262533, 36134.88369782727, 36232.09419764527, 39020.60979390283, 39319.606803931594, 39327.0, 33464.0, 33528.32943341168, 33894.491582625786, 34466.82766586151, 34795.65204347924, 32914.83542582272, 34216.65783342135, 34594.30811383809, 34723.65276347204, 35046.299074017865, 34032.829835850665, 34109.82945085358, 34416.311673765886, 34796.13009674779, 34858.65141348554, 30145.47937422393, 30973.33193422238, 31187.84406077955, 31302.0, 31384.95365165085, 24574.139905103235, 24759.62860557057, 24841.131146238895, 25152.0, 25176.74823251744], "value": 17667.868917815373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.1680118925281, 364.2514632430355, 365.1000284299202, 370.8145927036482, 381.79955523350253, 15904.443344482945, 16607.0, 17137.828621713812, 17158.828411715895, 17160.742588861176, 15703.685926281467, 16300.592485187875, 17039.488815335528, 17041.57396065099, 17092.059936703477, 4941.357623508939, 5092.236164575306, 5106.69359838409, 5111.744412779365, 5113.565346945496, 3605.513255710485, 3766.7928263945473, 5074.644774865761, 5459.590530710193, 5748.712564371785, 5683.062294721387, 5695.829125126232, 5710.343310519281, 5720.0561907285455, 5721.284839395075, 5618.5786066045, 5674.120511320752, 5687.17535957286, 5687.345955215162, 5696.8860622787315, 3261.72275356595, 4754.762261886892, 4855.854324370274, 4978.327925730016, 4989.126902792033, 18378.540536486562, 18987.145578448864, 19026.52433689169, 19108.904455477772, 19208.423747287463, 1945.0080458966029, 1945.6692362298443, 2154.633712268918, 2224.154821167946, 2297.1959814065112, 12806.320960100475, 12951.0, 13034.0, 13205.141665791789, 13252.602421927357, 1808.6111486030436, 1871.822176893193, 1876.6340563590106, 1887.122488043053, 1902.3436914264557, 60694.696526517524, 60746.0, 62607.0, 63435.391077578264, 63989.36010639927, 9160.22138118254, 9164.312676549285, 9251.629934802533, 9736.367136136128, 9909.157721593601, 12865.742685146244, 12909.99895016274, 12941.935290323489, 12942.547010854574, 12949.352532373343, 7011.475868687268, 7043.119610048744, 7302.087239095114, 7403.592802395812, 7426.962865185639, 6935.653217339112, 6991.685374158175, 7006.0, 7112.715491380287, 7122.71509139639, 5962.701864906738, 6131.724072416752, 6138.754449821957, 6146.139540464339, 6154.015357542861, 1559.306108781604, 1576.9211539423213, 1666.2837277604087, 1677.588990697287, 1677.9244933978, 915.8855143107112, 917.2157805076697, 961.3174646001418, 972.4262685015875, 1007.9244056695777, 15614.21928903573, 15985.680286394207, 16850.157492125345, 16893.408730694366, 16894.98630082199, 853.4921721575777, 866.9176428239307, 877.2236570635034, 887.2813021452515, 892.5983307511646, 7340.743073992385, 9870.21038316933, 10000.099991000845, 10028.0, 10033.648822291185, 363577.0, 363939.0, 377975.0, 399488.0, 401023.0, 63254.0, 63768.04347934692, 65095.34904650987, 65448.67275663591, 67138.3286167132, 966.7244835221928, 972.3145182646359, 1001.8497225416246, 1011.7571782772081, 1016.4460369098858, 14986.0, 15021.849781502046, 15065.924670376578, 15080.698386031998, 15405.845941540441, 30203.0, 30579.847100764353, 30656.846715766278, 30835.69164308418, 31029.8448507756, 42189.78905105455, 43058.27766889289, 43058.78470607627, 43226.0, 43251.56748432601, 7409.296116868889, 7414.184439711736, 7449.888251676338, 7489.513181643176, 7521.135069467081, 6156.045812899008, 8291.58542072906, 11222.382768947786, 11310.0, 11375.943120284346, 10172.949135254275, 10192.235582331206, 10239.948800256248, 10560.84158737635, 10916.290441121302, 10051.095401413908, 10186.694399168036, 10204.0, 10263.794724105626, 10435.478226088513, 10510.737231569272, 10587.841182382424, 10720.0, 10821.134309255398, 11050.834237486604, 7258.0, 7378.520396174232, 7425.888611670721, 7646.197149299243, 7849.215078492105, 9666.854997174907, 10248.590056397661, 10254.436006019441, 10263.076323130954, 10277.126444252022], "value": 8119.629868992485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.3428365824286, 1436.6982933583943, 1460.8100946876907, 1594.3463180096155, 1750.667373199092, 7434.442416818733, 7738.729144479944, 7751.18612545683, 7764.495307804996, 7770.222977702241, 7566.129895062069, 7701.345385642213, 7720.884186737189, 7723.266289702469, 7726.884096738553, 1925.0759635375027, 1986.3445063129134, 1991.5021244688828, 2211.2039665720285, 2240.8655480671214, 2233.9218127365543, 2307.9307620771406, 2315.490592069742, 2317.8377513574055, 2319.350581837088, 2219.556088782242, 2254.199759085526, 2255.875926824024, 2257.808086312665, 2271.3980795089315, 1918.673825449677, 2156.579467003919, 2228.565429741201, 2229.3312006398014, 2232.5758105959976, 2220.7224096987875, 2241.6301310283784, 2245.5396643688005, 2245.595792757303, 2246.1352379334076, 7633.427492937996, 7665.501742386727, 7681.039870016248, 7689.115751688571, 7691.307782299564, 4380.912381752347, 4499.235130027903, 4527.61515271199, 4538.841140560097, 4546.363509108727, 2822.350859302372, 3053.969460305413, 3058.770592205571, 3065.20304720772, 3067.1412004638737, 966.1932286540747, 975.0493269062678, 978.4667356290838, 992.8014397120605, 996.6960077176458, 10509.632162874263, 10516.737081572945, 10538.104261137813, 10544.261901666887, 10545.578176872916, 4148.43996060534, 4193.811278492475, 4341.696081274281, 4347.673924455678, 4409.0, 9127.315451341176, 9128.58921348541, 9166.12921772444, 9171.633134674672, 9173.770655733526, 4560.087982403533, 4563.155816174019, 4597.44830620321, 4601.7699115044115, 4603.148417542765, 3622.076370525499, 3991.381335892941, 4119.155573107506, 4182.079942412664, 4218.7679677618025, 3665.7433979621705, 3751.6998640109273, 3804.2011177653003, 3840.347140986039, 3903.3559462688904, 1196.7785959597502, 1199.1605875886914, 1214.690253985228, 1217.4825699077855, 1228.3919459867245, 847.2036285891243, 866.1554983890657, 871.8169184471205, 874.3966663002508, 898.3397203055749, 5262.315898933114, 5316.291377502636, 5340.664833791552, 5485.424030476823, 5487.835364939058, 871.7297637732323, 875.7329014650466, 906.0893801729352, 910.5811326789618, 914.6752902719572, 3687.483752274684, 3741.0, 3779.9433008504893, 3796.772193668389, 3823.9426408603895, 8816.955915220382, 9096.454212747256, 9221.17009469151, 9233.445993240428, 9260.675876344296, 9338.626454941726, 9413.76465588352, 9438.38650487716, 9440.48077355752, 9442.055794420641, 7239.131304243525, 7305.4155667546465, 7349.963250183715, 7350.77947661571, 7374.815629609303, 5279.577633789365, 5344.706041167773, 5351.117065684119, 5403.648762830403, 5572.498475137257, 8690.565471726262, 8722.651093956425, 8830.867536987078, 8893.28853691716, 8994.595243214202, 8717.564121794012, 8852.513111778657, 8976.685815996409, 8995.505247211204, 8999.505027223566, 5714.085746280742, 5884.499817515559, 5887.411258874078, 6341.8097457076365, 6490.740370385131, 6564.081028656087, 6590.1103351046995, 6636.469082473487, 7498.812529686801, 7503.437242206747, 6653.467722582279, 6687.130673012672, 6735.562188457735, 6767.627780471925, 6785.219699734594, 6649.534532582673, 6672.432843208382, 6684.231313398827, 6744.954532047541, 6845.486588505982, 6328.746850125944, 6339.144215530844, 6366.6180029198395, 6370.490360771035, 6388.456981156468, 4529.071540334289, 4641.443026836666, 4658.534146585314, 4722.456917454399, 4737.810487580596, 4446.777661116996, 4483.484399294123, 4548.181327360974, 4557.749323787223, 4613.284940834176], "value": 4149.53732953193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5627340356483, 308.63580974450156, 310.7296651912836, 313.21383327847127, 315.09410444970695, 5063.088644044071, 5092.719900405481, 5093.79624815007, 5105.157648987913, 5117.130087885059, 4998.525140111684, 5018.0, 5028.84913452597, 5040.3951525816865, 5049.747512624373, 3735.2716220337047, 3803.543574771031, 3855.7108216883707, 3952.861649842256, 3964.1278918638, 3903.750799744083, 3956.6834653227816, 3964.0882597002706, 3976.383660532622, 3976.403539469074, 3707.536557930259, 3914.9233960660763, 3918.373060310351, 3926.5877082906313, 3944.3886197639413, 3783.81080945953, 3865.439511270878, 3865.632764887331, 3891.416287556861, 3920.470736450571, 3464.4110501214855, 3465.151037995682, 3469.421413256962, 3469.444888817802, 3471.1669199392218, 4838.443578988391, 4848.418189817209, 4862.5623693867365, 4871.29366241893, 4890.5109489051165, 4214.957850421518, 4467.463904331468, 4475.70907890986, 4510.458744950594, 4529.773511324421, 5272.393674727417, 5276.707206734336, 5290.841274761725, 5296.549793267577, 5300.204969254604, 3712.2204337088974, 3720.9069773255887, 3723.255348930225, 3724.1062145085257, 3724.404095344732, 5237.319148510707, 5525.723713814334, 5561.860953476155, 5589.972050139764, 5597.412271711493, 3762.1347090169415, 3764.8682296119505, 3767.416050512175, 3777.0934975605655, 3805.06775839921, 3842.442845787345, 3845.942310865339, 3849.5188101487315, 3852.8651497197466, 3853.421986701961, 4262.825958761055, 4424.424824772759, 4433.889152771142, 4440.977795111004, 4444.933326000112, 5300.390455097636, 5321.36143662763, 5321.813736519203, 5322.654027488201, 5341.0, 1320.6830360713552, 1342.2952849880596, 1343.6909510812372, 1344.6503908983734, 1347.2253454263837, 839.1650307943635, 878.2578720980761, 886.8315020146151, 904.1004200820227, 904.6788390121544, 4690.202665546865, 4709.67032307742, 4715.104130215248, 4725.267583524559, 4733.715977041388, 5419.160030195326, 5429.212764149176, 5435.402105768362, 5446.891062178814, 5459.8362049137795, 4448.5551444855255, 4641.512641172628, 4708.387909571734, 4717.764111794397, 4726.480087190406, 2900.7374248086526, 2927.458420192271, 2941.294089418524, 2946.5138252188576, 2954.5863579098946, 5212.270282160501, 5239.659422137549, 5241.633085684041, 5247.63266571344, 5252.632315737938, 5469.699166545878, 5616.213730077792, 5655.144152203194, 5655.802046928337, 5668.348139963874, 5197.376314842168, 5209.843704688866, 5214.243934629458, 5229.738513074255, 5232.476752324813, 5472.781088756406, 5497.780088796563, 5501.394846566955, 5503.834884953458, 5506.339239291311, 5155.917257375843, 5390.51485366319, 5392.031908353501, 5407.648502847303, 5414.75633596497, 5212.661177023633, 5226.216067589892, 5246.790128394821, 5253.106971814725, 5257.763400647056, 3812.6759225466144, 3822.7515211511163, 3839.2321535692413, 3843.8846834595006, 3851.2490064437166, 5245.868853278546, 5483.095289277225, 5520.1167813149705, 5537.307836520435, 5553.888922221452, 5343.4389389113585, 5343.7595308212, 5363.222332761806, 5369.865753356197, 5379.606075296456, 5193.117170081171, 5328.413874473727, 5331.120365139708, 5371.5702743781185, 5393.946060539344, 4987.600991920565, 5267.446918073547, 5276.182191760283, 5276.81531146408, 5294.152935530296, 5196.959778529603, 5379.596530260168, 5386.192071189353, 5392.811251606175, 5410.8647283816645, 5194.870128246824, 5234.528892399702, 5276.15581506957, 5290.867728306823, 5296.629235953446], "value": 3990.288744015755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.9723611055557, 788.3968763895624, 800.4716886854677, 805.5730462854689, 807.1283014344508, 11392.544298228071, 11635.534578616865, 11657.475413606388, 11679.941600291997, 11728.53085876565, 12044.939775301133, 12131.02951763859, 12142.150049496538, 12160.817587736192, 12236.938815305912, 621.139721485741, 759.8594260061878, 783.2793829676683, 787.094840932926, 790.5572879187645, 787.6888628991545, 796.5260669901428, 796.5778137587088, 796.7330944133722, 799.6801279488222, 837.9916200837974, 840.6595328891808, 844.6579135450122, 844.8690452979768, 844.9028361738386, 632.3644737039292, 824.3281725393784, 845.4631309118693, 847.3433089355736, 848.804774901776, 612.7395856760859, 616.5653214483823, 619.7706848466051, 620.1751670278563, 620.509797260164, 11708.648740537797, 11730.296182229009, 11747.588834390755, 11750.529978800838, 11768.235064720851, 12339.444724987397, 12782.296973666445, 12977.610671679864, 13112.409941552558, 13179.934100329532, 9198.126178013077, 9607.0, 9618.90381096187, 9753.512324383822, 9834.704958851245, 4031.3751368537924, 4101.343784994387, 4148.336266197424, 4149.0, 4149.668026557898, 46579.53420465786, 47152.29271560929, 47348.76325618384, 47479.287810683214, 47787.28319075217, 9644.276679248944, 9976.650817221362, 10088.243381746399, 10095.495225238856, 10335.069843714102, 15935.36258549645, 16110.436134735228, 16203.675926481405, 16206.59483512898, 16219.918900405422, 6392.6849774389975, 6544.443722283564, 6638.20341559016, 6690.632015239208, 6973.163220413583, 3897.4933258676756, 3937.114149316381, 3967.713218582285, 3974.980125099356, 4097.323941549671, 2866.1115054333222, 2915.985420072886, 2918.1829087855435, 2919.4161167766533, 2921.547160190174, 509.84194899581246, 510.57112025898425, 521.6687403498805, 522.7934965688607, 524.4860037163601, 570.3099249907658, 598.61090291311, 601.7232073246269, 620.1380081686459, 660.9008648702733, 7719.382449404035, 7792.454528183086, 7792.532448053135, 7838.647260873275, 8098.797530061795, 619.7335145887222, 639.9040143978348, 640.3436477610394, 647.346180357842, 653.9247986481521, 3737.9626203738158, 3775.5469343678383, 3821.904452388657, 3856.325143099946, 3920.4315374270573, 51031.744841275555, 53065.0, 53258.73370633122, 53264.73367633137, 53268.733656332246, 38119.0, 40481.1903761929, 44443.111137777065, 46414.0, 46642.766786165856, 35415.0, 35719.4642080369, 35920.46119308213, 39289.21421571496, 40073.59926400757, 7979.202079791974, 8147.877781833158, 8382.0, 8416.705415310435, 8439.324854011787, 26716.19851404461, 27148.864255678596, 27288.863555682095, 27331.86334068317, 27350.72649273482, 32200.516992244666, 33983.49024764581, 34640.653593464755, 37242.8137859309, 38488.422673659355, 10553.208509361983, 10621.203409744145, 10758.946205269236, 10939.835902461311, 11028.28316159447, 11699.23954942926, 11757.647270581896, 11880.76238475243, 12157.939210303892, 12518.37408129608, 11042.558297668003, 11173.994340509393, 11546.979278626039, 11969.222000569935, 11969.521219151136, 11561.653150405502, 11787.057035437316, 12175.452104655134, 12378.381080946097, 12438.564650237198, 11175.664730058112, 11348.092152627605, 11789.351585662871, 12053.397330133283, 12074.879251207376, 9771.364861283993, 10075.193984481077, 10254.53854576531, 10369.896301036893, 10401.895981040092, 9216.631334746535, 9352.953235233781, 9797.31418800677, 9829.852552211865, 9859.802803944025], "value": 5960.917671749669, "unit": "score"}], "name": "dromaeo_css", "value": 6329.980265267108, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 111.0, 113.0, 115.0, 114.0, 100.0, 113.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 137.0, 159.0, 189.0, 133.0, 158.0, 159.0, 137.0, 187.0, 130.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 105.0, 122.0, 75.0, 74.0, 77.0, 119.0, 100.0, 76.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 134.0, 94.0, 95.0, 94.0, 143.0, 95.0, 95.0, 147.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 93.0, 63.0, 63.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 86.0, 87.0, 80.0, 81.0, 80.0, 85.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 136.0, 141.0, 132.0, 136.0, 132.0, 142.0, 214.0, 145.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 174.0, 176.0, 173.0, 175.0, 175.0, 178.0, 179.0, 175.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 72.0, 72.0, 74.0, 73.0, 74.0, 75.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1590.2, "alertThreshold": 2.0}]} 02:44:05 INFO - Return code: 0 02:44:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:06 ERROR - # TBPL SUCCESS # 02:44:06 INFO - Running post-action listener: _resource_record_post_action 02:44:06 INFO - Running post-run listener: _resource_record_post_run 02:44:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 517840896; Read time: 0; Write time: 521148 02:44:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233852928; Read time: 0; Write time: 315660 02:44:07 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283987968; Read time: 0; Write time: 205488 02:44:07 INFO - Running post-run listener: _upload_blobber_files 02:44:07 INFO - Blob upload gear active. 02:44:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:44:07 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 02:44:07 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'] 02:44:07 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 02:44:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:08 INFO - (blobuploader) - INFO - Done attempting. 02:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:09 INFO - (blobuploader) - INFO - Done attempting. 02:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:09 INFO - Return code: 0 02:44:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d4b19449dc68d047e7ba725cf5f8fa7e641eecc71b91d76915c5f4fd91fbe7fbe23ff9db51118f27c49a68198048a68d30b7fff28aae4b98524846cc7e80efa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323f4117d5a1249180f20531634d8acc87d42f8888bc698450481239d7003e2d2f775afe7882723d95ea507287075d279d89cf3955598ab96ab81b6586a12f26"} 02:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:44:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:44:09 INFO - Contents: 02:44:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d4b19449dc68d047e7ba725cf5f8fa7e641eecc71b91d76915c5f4fd91fbe7fbe23ff9db51118f27c49a68198048a68d30b7fff28aae4b98524846cc7e80efa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323f4117d5a1249180f20531634d8acc87d42f8888bc698450481239d7003e2d2f775afe7882723d95ea507287075d279d89cf3955598ab96ab81b6586a12f26"} 02:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:09 INFO - Copying logs to upload dir... 02:44:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.806003 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-21 02:44:08.284671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 02:44:08.288637) ========= 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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 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/3d4b19449dc68d047e7ba725cf5f8fa7e641eecc71b91d76915c5f4fd91fbe7fbe23ff9db51118f27c49a68198048a68d30b7fff28aae4b98524846cc7e80efa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323f4117d5a1249180f20531634d8acc87d42f8888bc698450481239d7003e2d2f775afe7882723d95ea507287075d279d89cf3955598ab96ab81b6586a12f26"} build_url:https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/dIxN06OvTvuLKo9lhIaNQw/artifacts/public/build/firefox-48.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/3d4b19449dc68d047e7ba725cf5f8fa7e641eecc71b91d76915c5f4fd91fbe7fbe23ff9db51118f27c49a68198048a68d30b7fff28aae4b98524846cc7e80efa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/323f4117d5a1249180f20531634d8acc87d42f8888bc698450481239d7003e2d2f775afe7882723d95ea507287075d279d89cf3955598ab96ab81b6586a12f26"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 02:44:08.313958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:44:08.314336) ========= 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=232498196343f89f466a4a9a000001c8-1461224125.191780-823850238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 02:44:08.396180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 02:44:08.396495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 02:44:08.396826) ========= ========= Total master_lag: 0.15 =========