builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1461187876.1 results: success (0) buildid: 20160420141303 builduid: 9f1acf046f0e4dccbe6dfecaac9bc874 revision: c1a9497a212d54fda334e9174aac33926196df8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.103459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.103846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.104131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.159414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.159687) ========= 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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 14:31:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-04-20 14:31:16 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120812 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.306169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.306460) ========= 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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016557 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.356595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.357014) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1a9497a212d54fda334e9174aac33926196df8e --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 c1a9497a212d54fda334e9174aac33926196df8e --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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:31:16,494 truncating revision to first 12 chars 2016-04-20 14:31:16,494 Setting DEBUG logging. 2016-04-20 14:31:16,494 attempt 1/10 2016-04-20 14:31:16,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1a9497a212d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:31:16,764 unpacking tar archive at: fx-team-c1a9497a212d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.913329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.913631) ========= script_repo_revision: c1a9497a212d54fda334e9174aac33926196df8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.914039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.914306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:16.927649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-20 14:31:16.927917) ========= /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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:17 INFO - MultiFileLogger online at 20160420 14:31:17 in /builds/slave/test 14:31:17 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 14:31:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:17 INFO - {'append_to_log': False, 14:31:17 INFO - 'base_work_dir': '/builds/slave/test', 14:31:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:31:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:17 INFO - 'branch': 'Fx-Team-Non-PGO', 14:31:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:17 INFO - 'config_files': ('talos/linux_config.py',), 14:31:17 INFO - 'default_actions': ('clobber', 14:31:17 INFO - 'read-buildbot-config', 14:31:17 INFO - 'download-and-extract', 14:31:17 INFO - 'populate-webroot', 14:31:17 INFO - 'create-virtualenv', 14:31:17 INFO - 'install', 14:31:17 INFO - 'run-tests'), 14:31:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:17 INFO - 'download_minidump_stackwalk': True, 14:31:17 INFO - 'download_symbols': 'ondemand', 14:31:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:17 INFO - 'installer_path': 'installer.exe', 14:31:17 INFO - 'log_level': 'info', 14:31:17 INFO - 'log_name': 'talos', 14:31:17 INFO - 'log_to_console': True, 14:31:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:17 INFO - 'opt_config_files': (), 14:31:17 INFO - 'pip_index': False, 14:31:17 INFO - 'sps_profile': False, 14:31:17 INFO - 'sps_profile_interval': 0, 14:31:17 INFO - 'suite': 'dromaeojs', 14:31:17 INFO - 'system_bits': '32', 14:31:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:17 INFO - 'title': 'talos-linux64-ix-054', 14:31:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:17 INFO - 'use_talos_json': True, 14:31:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:17 INFO - 'work_dir': 'build'} 14:31:17 INFO - ##### 14:31:17 INFO - ##### Running clobber step. 14:31:17 INFO - ##### 14:31:17 INFO - Running pre-action listener: _resource_record_pre_action 14:31:17 INFO - Running main action method: clobber 14:31:17 INFO - rmtree: /builds/slave/test/build 14:31:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:17 INFO - Running post-action listener: _resource_record_post_action 14:31:17 INFO - ##### 14:31:17 INFO - ##### Running read-buildbot-config step. 14:31:17 INFO - ##### 14:31:17 INFO - Running pre-action listener: _resource_record_pre_action 14:31:17 INFO - Running main action method: read_buildbot_config 14:31:17 INFO - Using buildbot properties: 14:31:17 INFO - { 14:31:17 INFO - "project": "", 14:31:17 INFO - "product": "firefox", 14:31:17 INFO - "script_repo_revision": "production", 14:31:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:31:17 INFO - "repository": "", 14:31:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:31:17 INFO - "buildid": "20160420141303", 14:31:17 INFO - "pgo_build": "False", 14:31:17 INFO - "basedir": "/builds/slave/test", 14:31:17 INFO - "buildnumber": 1577, 14:31:17 INFO - "slavename": "talos-linux64-ix-054", 14:31:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:31:17 INFO - "platform": "ubuntu64_hw", 14:31:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:31:17 INFO - "branch": "fx-team", 14:31:17 INFO - "repo_path": "integration/fx-team", 14:31:17 INFO - "revision": "c1a9497a212d54fda334e9174aac33926196df8e", 14:31:17 INFO - "stage_platform": "linux64", 14:31:17 INFO - "builduid": "9f1acf046f0e4dccbe6dfecaac9bc874", 14:31:17 INFO - "slavebuilddir": "test" 14:31:17 INFO - } 14:31:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:31:17 INFO - Running post-action listener: _resource_record_post_action 14:31:17 INFO - ##### 14:31:17 INFO - ##### Running download-and-extract step. 14:31:17 INFO - ##### 14:31:17 INFO - Running pre-action listener: _resource_record_pre_action 14:31:17 INFO - Running main action method: download_and_extract 14:31:17 INFO - mkdir: /builds/slave/test/build/tests 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:17 INFO - https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:31:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:20 INFO - Downloaded 1361 bytes. 14:31:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:20 INFO - Using the following test package requirements: 14:31:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:31:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'jsshell-linux-x86_64.zip'], 14:31:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:31:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:31:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:20 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')]} 14:31:20 INFO - https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:22 INFO - Downloaded 22268267 bytes. 14:31:22 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'] 14:31:22 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 14:31:24 INFO - Return code: 0 14:31:24 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 14:31: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')]} 14:31:24 INFO - https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:28 INFO - Downloaded 22268267 bytes. 14:31: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'] 14:31: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 14:31:29 INFO - Return code: 0 14:31: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')]} 14:31:29 INFO - https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:40 INFO - Downloaded 10845952 bytes. 14:31:40 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'] 14:31:40 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 14:31:40 INFO - Return code: 0 14:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:40 INFO - https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JRV5QJqMSOy0i1_aQIthdw/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 14:31:41 INFO - Downloaded 54656433 bytes. 14:31:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:41 INFO - mkdir: /builds/slave/test/properties 14:31:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:41 INFO - Contents: 14:31:41 INFO - build_url:https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:42 INFO - Running post-action listener: _resource_record_post_action 14:31:42 INFO - Running post-action listener: set_extra_try_arguments 14:31:42 INFO - ##### 14:31:42 INFO - ##### Running populate-webroot step. 14:31:42 INFO - ##### 14:31:42 INFO - Running pre-action listener: _resource_record_pre_action 14:31:42 INFO - Running main action method: populate_webroot 14:31:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:42 INFO - '--tppagecycles', 14:31:42 INFO - '7'], 14:31:42 INFO - 'tests': ['tsvgm']}}, 14:31:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['damp', 'tps']}, 14:31:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'tests': ['damp', 'tps']}, 14:31:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['dromaeo_dom']}, 14:31:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['a11yr', 14:31:42 INFO - 'ts_paint', 14:31:42 INFO - 'tpaint', 14:31:42 INFO - 'sessionrestore', 14:31:42 INFO - 'sessionrestore_no_auto_restore', 14:31:42 INFO - 'tabpaint']}, 14:31:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['tsvgx', 14:31:42 INFO - 'tsvgr_opacity', 14:31:42 INFO - 'tart', 14:31:42 INFO - 'tscrollx', 14:31:42 INFO - 'cart']}, 14:31:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:42 INFO - 'tsvgr_opacity', 14:31:42 INFO - 'tart', 14:31:42 INFO - 'tscrollx', 14:31:42 INFO - 'cart']}, 14:31:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'talos_options': ['--disable-e10s'], 14:31:42 INFO - 'tests': ['tp5o']}, 14:31:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'tests': ['tp5o']}, 14:31:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'talos_options': ['--disable-e10s', 14:31:42 INFO - '--xperf_path', 14:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:42 INFO - 'tests': ['tp5n']}, 14:31:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:42 INFO - 'talos_options': ['--xperf_path', 14:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:42 INFO - 'tests': ['tp5n']}}, 14:31:42 INFO - 'talos.zip': {'path': '', 14:31:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:42 INFO - Running post-action listener: _resource_record_post_action 14:31:42 INFO - ##### 14:31:42 INFO - ##### Running create-virtualenv step. 14:31:42 INFO - ##### 14:31:42 INFO - Running pre-action listener: _resource_record_pre_action 14:31:42 INFO - Running main action method: create_virtualenv 14:31:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:42 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 14:31:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:42 INFO - Using real prefix '/usr' 14:31:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:45 INFO - Installing pip.................done. 14:31:45 INFO - Return code: 0 14:31:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:31:45 INFO - Using env: {'DISPLAY': ':0', 14:31:45 INFO - 'HOME': '/home/cltbld', 14:31:45 INFO - 'LANG': 'en_US.UTF-8', 14:31:45 INFO - 'LANGUAGE': 'en_US:en', 14:31:45 INFO - 'LOGNAME': 'cltbld', 14:31:45 INFO - 'MAIL': '/var/mail/cltbld', 14:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:45 INFO - 'MOZ_NO_REMOTE': '1', 14:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:45 INFO - 'NO_EM_RESTART': '1', 14:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:45 INFO - 'PWD': '/builds/slave/test', 14:31:45 INFO - 'SHELL': '/bin/bash', 14:31:45 INFO - 'SHLVL': '1', 14:31:45 INFO - 'TERM': 'linux', 14:31:45 INFO - 'TMOUT': '86400', 14:31:45 INFO - 'USER': 'cltbld', 14:31:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:45 INFO - '_': '/tools/buildbot/bin/python'} 14:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:45 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 14:31:45 INFO - Cleaning up... 14:31:45 INFO - Return code: 0 14:31:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:31:45 INFO - Using env: {'DISPLAY': ':0', 14:31:45 INFO - 'HOME': '/home/cltbld', 14:31:45 INFO - 'LANG': 'en_US.UTF-8', 14:31:45 INFO - 'LANGUAGE': 'en_US:en', 14:31:45 INFO - 'LOGNAME': 'cltbld', 14:31:45 INFO - 'MAIL': '/var/mail/cltbld', 14:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:45 INFO - 'MOZ_NO_REMOTE': '1', 14:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:45 INFO - 'NO_EM_RESTART': '1', 14:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:45 INFO - 'PWD': '/builds/slave/test', 14:31:45 INFO - 'SHELL': '/bin/bash', 14:31:45 INFO - 'SHLVL': '1', 14:31:45 INFO - 'TERM': 'linux', 14:31:45 INFO - 'TMOUT': '86400', 14:31:45 INFO - 'USER': 'cltbld', 14:31:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:45 INFO - '_': '/tools/buildbot/bin/python'} 14:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:45 INFO - Downloading/unpacking psutil>=0.7.1 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:47 INFO - Installing collected packages: psutil 14:31:47 INFO - Running setup.py install for psutil 14:31:48 INFO - building 'psutil._psutil_linux' extension 14:31:48 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 14:31:48 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 14:31:48 INFO - building 'psutil._psutil_posix' extension 14:31:48 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 14:31:48 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 14:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:48 INFO - Successfully installed psutil 14:31:48 INFO - Cleaning up... 14:31:48 INFO - Return code: 0 14:31:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:31:48 INFO - Using env: {'DISPLAY': ':0', 14:31:48 INFO - 'HOME': '/home/cltbld', 14:31:48 INFO - 'LANG': 'en_US.UTF-8', 14:31:48 INFO - 'LANGUAGE': 'en_US:en', 14:31:48 INFO - 'LOGNAME': 'cltbld', 14:31:48 INFO - 'MAIL': '/var/mail/cltbld', 14:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:48 INFO - 'MOZ_NO_REMOTE': '1', 14:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:48 INFO - 'NO_EM_RESTART': '1', 14:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:48 INFO - 'PWD': '/builds/slave/test', 14:31:48 INFO - 'SHELL': '/bin/bash', 14:31:48 INFO - 'SHLVL': '1', 14:31:48 INFO - 'TERM': 'linux', 14:31:48 INFO - 'TMOUT': '86400', 14:31:48 INFO - 'USER': 'cltbld', 14:31:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:48 INFO - '_': '/tools/buildbot/bin/python'} 14:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:31:50 INFO - Installing collected packages: mozsystemmonitor 14:31:50 INFO - Running setup.py install for mozsystemmonitor 14:31:50 INFO - Successfully installed mozsystemmonitor 14:31:50 INFO - Cleaning up... 14:31:50 INFO - Return code: 0 14:31:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:50 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')]} 14:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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')]} 14:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:50 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 14:31:50 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 14:31:50 INFO - Using env: {'DISPLAY': ':0', 14:31:50 INFO - 'HOME': '/home/cltbld', 14:31:50 INFO - 'LANG': 'en_US.UTF-8', 14:31:50 INFO - 'LANGUAGE': 'en_US:en', 14:31:50 INFO - 'LOGNAME': 'cltbld', 14:31:50 INFO - 'MAIL': '/var/mail/cltbld', 14:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:50 INFO - 'MOZ_NO_REMOTE': '1', 14:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:50 INFO - 'NO_EM_RESTART': '1', 14:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:50 INFO - 'PWD': '/builds/slave/test', 14:31:50 INFO - 'SHELL': '/bin/bash', 14:31:50 INFO - 'SHLVL': '1', 14:31:50 INFO - 'TERM': 'linux', 14:31:50 INFO - 'TMOUT': '86400', 14:31:50 INFO - 'USER': 'cltbld', 14:31:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:50 INFO - '_': '/tools/buildbot/bin/python'} 14:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 INFO - Downloading docopt-0.6.1.tar.gz 14:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:53 INFO - Running setup.py install for blobuploader 14:31:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:53 INFO - Running setup.py install for requests 14:31:54 INFO - Running setup.py install for docopt 14:31:54 INFO - Successfully installed blobuploader requests docopt 14:31:54 INFO - Cleaning up... 14:31:54 INFO - Return code: 0 14:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:54 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')]} 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:54 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')]} 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:54 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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:54 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 14:31:54 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 14:31:54 INFO - Using env: {'DISPLAY': ':0', 14:31:54 INFO - 'HOME': '/home/cltbld', 14:31:54 INFO - 'LANG': 'en_US.UTF-8', 14:31:54 INFO - 'LANGUAGE': 'en_US:en', 14:31:54 INFO - 'LOGNAME': 'cltbld', 14:31:54 INFO - 'MAIL': '/var/mail/cltbld', 14:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:54 INFO - 'MOZ_NO_REMOTE': '1', 14:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:54 INFO - 'NO_EM_RESTART': '1', 14:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:54 INFO - 'PWD': '/builds/slave/test', 14:31:54 INFO - 'SHELL': '/bin/bash', 14:31:54 INFO - 'SHLVL': '1', 14:31:54 INFO - 'TERM': 'linux', 14:31:54 INFO - 'TMOUT': '86400', 14:31:54 INFO - 'USER': 'cltbld', 14:31:54 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:54 INFO - '_': '/tools/buildbot/bin/python'} 14:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:54 INFO - Running setup.py (path:/tmp/pip-hmRGNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:54 INFO - Running setup.py (path:/tmp/pip-GBb3yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:54 INFO - Running setup.py (path:/tmp/pip-m_oYzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:54 INFO - Running setup.py (path:/tmp/pip-coDuZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:54 INFO - Running setup.py (path:/tmp/pip-REyiq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:54 INFO - Running setup.py (path:/tmp/pip-befOId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:54 INFO - Running setup.py (path:/tmp/pip-FaH68C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:54 INFO - Running setup.py (path:/tmp/pip-n0zxjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:55 INFO - Running setup.py (path:/tmp/pip-8AeBFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:55 INFO - Running setup.py (path:/tmp/pip-b1_tj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:55 INFO - Running setup.py (path:/tmp/pip-VhMeOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:55 INFO - Running setup.py (path:/tmp/pip-AVvR3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:55 INFO - Running setup.py (path:/tmp/pip-0RZlZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:55 INFO - Running setup.py (path:/tmp/pip-xOmrmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:55 INFO - Running setup.py (path:/tmp/pip-TlwLEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:55 INFO - Running setup.py (path:/tmp/pip-oXgQlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:55 INFO - Running setup.py (path:/tmp/pip-Jndt6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:55 INFO - Running setup.py install for manifestparser 14:31:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for mozcrash 14:31:55 INFO - Running setup.py install for mozdebug 14:31:55 INFO - Running setup.py install for mozdevice 14:31:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for mozfile 14:31:56 INFO - Running setup.py install for mozhttpd 14:31:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for mozinfo 14:31:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for mozInstall 14:31:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for mozleak 14:31:56 INFO - Running setup.py install for mozlog 14:31:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for moznetwork 14:31:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Running setup.py install for mozprocess 14:31:56 INFO - Running setup.py install for mozprofile 14:31:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Running setup.py install for mozrunner 14:31:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Running setup.py install for mozscreenshot 14:31:57 INFO - Running setup.py install for moztest 14:31:57 INFO - Running setup.py install for mozversion 14:31:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:57 INFO - Cleaning up... 14:31:57 INFO - Return code: 0 14:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:57 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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:31:57 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 14:31:57 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 14:31:57 INFO - Using env: {'DISPLAY': ':0', 14:31:57 INFO - 'HOME': '/home/cltbld', 14:31:57 INFO - 'LANG': 'en_US.UTF-8', 14:31:57 INFO - 'LANGUAGE': 'en_US:en', 14:31:57 INFO - 'LOGNAME': 'cltbld', 14:31:57 INFO - 'MAIL': '/var/mail/cltbld', 14:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:57 INFO - 'MOZ_NO_REMOTE': '1', 14:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:57 INFO - 'NO_EM_RESTART': '1', 14:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:57 INFO - 'PWD': '/builds/slave/test', 14:31:57 INFO - 'SHELL': '/bin/bash', 14:31:57 INFO - 'SHLVL': '1', 14:31:57 INFO - 'TERM': 'linux', 14:31:57 INFO - 'TMOUT': '86400', 14:31:57 INFO - 'USER': 'cltbld', 14:31:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:57 INFO - '_': '/tools/buildbot/bin/python'} 14:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:57 INFO - Running setup.py (path:/tmp/pip-4RXzqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:57 INFO - Running setup.py (path:/tmp/pip-3LyN_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:57 INFO - Running setup.py (path:/tmp/pip-gfkMOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:57 INFO - Running setup.py (path:/tmp/pip-B8YTqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:58 INFO - Running setup.py (path:/tmp/pip-53wMet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:58 INFO - Running setup.py (path:/tmp/pip-nzmyVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:58 INFO - Running setup.py (path:/tmp/pip-BXvo7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:58 INFO - Running setup.py (path:/tmp/pip-9vPmzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:58 INFO - Running setup.py (path:/tmp/pip-YFv0pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:58 INFO - Running setup.py (path:/tmp/pip-anyt74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:58 INFO - Running setup.py (path:/tmp/pip-KfkSzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:58 INFO - Running setup.py (path:/tmp/pip-OHhJXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:58 INFO - Running setup.py (path:/tmp/pip-jjIMxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:58 INFO - Running setup.py (path:/tmp/pip-vp8JSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:58 INFO - Running setup.py (path:/tmp/pip-k_LoZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:58 INFO - Running setup.py (path:/tmp/pip-3NbdVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:58 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)) 14:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:58 INFO - Running setup.py (path:/tmp/pip-PgJHDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:58 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)) 14:31:58 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)) 14:31:58 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)) 14:31:58 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)) 14:31:58 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)) 14:31:58 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)) 14:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:58 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 14:31:58 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 14:31:58 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 14:31:58 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 14:31:58 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 14:31:58 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 14:32:00 INFO - Downloading blessings-1.6.tar.gz 14:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:00 INFO - Installing collected packages: blessings 14:32:00 INFO - Running setup.py install for blessings 14:32:01 INFO - Successfully installed blessings 14:32:01 INFO - Cleaning up... 14:32:01 INFO - Return code: 0 14:32:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:01 INFO - Reading from file tmpfile_stdout 14:32:01 INFO - Current package versions: 14:32:01 INFO - argparse == 1.2.1 14:32:01 INFO - blessings == 1.6 14:32:01 INFO - blobuploader == 1.2.4 14:32:01 INFO - docopt == 0.6.1 14:32:01 INFO - manifestparser == 1.1 14:32:01 INFO - mozInstall == 1.12 14:32:01 INFO - mozcrash == 0.17 14:32:01 INFO - mozdebug == 0.1 14:32:01 INFO - mozdevice == 0.48 14:32:01 INFO - mozfile == 1.2 14:32:01 INFO - mozhttpd == 0.7 14:32:01 INFO - mozinfo == 0.9 14:32:01 INFO - mozleak == 0.1 14:32:01 INFO - mozlog == 3.1 14:32:01 INFO - moznetwork == 0.27 14:32:01 INFO - mozprocess == 0.22 14:32:01 INFO - mozprofile == 0.28 14:32:01 INFO - mozrunner == 6.11 14:32:01 INFO - mozscreenshot == 0.1 14:32:01 INFO - mozsystemmonitor == 0.0 14:32:01 INFO - moztest == 0.7 14:32:01 INFO - mozversion == 1.4 14:32:01 INFO - psutil == 3.1.1 14:32:01 INFO - requests == 1.2.3 14:32:01 INFO - wsgiref == 0.1.2 14:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:32:01 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 14:32:01 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 14:32:01 INFO - Using env: {'DISPLAY': ':0', 14:32:01 INFO - 'HOME': '/home/cltbld', 14:32:01 INFO - 'LANG': 'en_US.UTF-8', 14:32:01 INFO - 'LANGUAGE': 'en_US:en', 14:32:01 INFO - 'LOGNAME': 'cltbld', 14:32:01 INFO - 'MAIL': '/var/mail/cltbld', 14:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:01 INFO - 'MOZ_NO_REMOTE': '1', 14:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:01 INFO - 'NO_EM_RESTART': '1', 14:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:01 INFO - 'PWD': '/builds/slave/test', 14:32:01 INFO - 'SHELL': '/bin/bash', 14:32:01 INFO - 'SHLVL': '1', 14:32:01 INFO - 'TERM': 'linux', 14:32:01 INFO - 'TMOUT': '86400', 14:32:01 INFO - 'USER': 'cltbld', 14:32:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:01 INFO - '_': '/tools/buildbot/bin/python'} 14:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 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)) 14:32:01 INFO - Cleaning up... 14:32:01 INFO - Return code: 0 14:32:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 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 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:32:01 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 14:32:01 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 14:32:01 INFO - Using env: {'DISPLAY': ':0', 14:32:01 INFO - 'HOME': '/home/cltbld', 14:32:01 INFO - 'LANG': 'en_US.UTF-8', 14:32:01 INFO - 'LANGUAGE': 'en_US:en', 14:32:01 INFO - 'LOGNAME': 'cltbld', 14:32:01 INFO - 'MAIL': '/var/mail/cltbld', 14:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:01 INFO - 'MOZ_NO_REMOTE': '1', 14:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:01 INFO - 'NO_EM_RESTART': '1', 14:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:01 INFO - 'PWD': '/builds/slave/test', 14:32:01 INFO - 'SHELL': '/bin/bash', 14:32:01 INFO - 'SHLVL': '1', 14:32:01 INFO - 'TERM': 'linux', 14:32:01 INFO - 'TMOUT': '86400', 14:32:01 INFO - 'USER': 'cltbld', 14:32:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:01 INFO - '_': '/tools/buildbot/bin/python'} 14:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:01 INFO - Downloading/unpacking jsonschema 14:32:01 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 14:32:01 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 14:32:01 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 14:32:01 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 14:32:01 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 14:32:01 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 14:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:03 INFO - Downloading/unpacking functools32 (from jsonschema) 14:32:03 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 14:32:03 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 14:32:03 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 14:32:03 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 14:32:03 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 14:32:03 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 14:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:03 INFO - warning: no files found matching '*.txt' 14:32:03 INFO - no previously-included directories found matching 'build' 14:32:03 INFO - no previously-included directories found matching 'dist' 14:32:03 INFO - no previously-included directories found matching '.git*' 14:32:03 INFO - Installing collected packages: jsonschema, functools32 14:32:03 INFO - Running setup.py install for functools32 14:32:03 INFO - warning: no files found matching '*.txt' 14:32:03 INFO - no previously-included directories found matching 'build' 14:32:03 INFO - no previously-included directories found matching 'dist' 14:32:03 INFO - no previously-included directories found matching '.git*' 14:32:04 INFO - Successfully installed jsonschema functools32 14:32:04 INFO - Cleaning up... 14:32:04 INFO - Return code: 0 14:32:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1be88ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', '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 14:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:32:04 INFO - Using env: {'DISPLAY': ':0', 14:32:04 INFO - 'HOME': '/home/cltbld', 14:32:04 INFO - 'LANG': 'en_US.UTF-8', 14:32:04 INFO - 'LANGUAGE': 'en_US:en', 14:32:04 INFO - 'LOGNAME': 'cltbld', 14:32:04 INFO - 'MAIL': '/var/mail/cltbld', 14:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:04 INFO - 'MOZ_NO_REMOTE': '1', 14:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:04 INFO - 'NO_EM_RESTART': '1', 14:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:04 INFO - 'PWD': '/builds/slave/test', 14:32:04 INFO - 'SHELL': '/bin/bash', 14:32:04 INFO - 'SHLVL': '1', 14:32:04 INFO - 'TERM': 'linux', 14:32:04 INFO - 'TMOUT': '86400', 14:32:04 INFO - 'USER': 'cltbld', 14:32:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:04 INFO - '_': '/tools/buildbot/bin/python'} 14:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:04 INFO - Downloading/unpacking flake8 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 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 14:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:06 INFO - no previously-included directories found matching 'docs/_build' 14:32:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:06 INFO - Running setup.py install for pep8 14:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:07 INFO - no previously-included directories found matching 'docs/_build' 14:32:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:07 INFO - Cleaning up... 14:32:07 INFO - Return code: 0 14:32:07 INFO - Running post-action listener: _resource_record_post_action 14:32:07 INFO - Running post-action listener: _start_resource_monitoring 14:32:07 INFO - Starting resource monitoring. 14:32:07 INFO - ##### 14:32:07 INFO - ##### Running install step. 14:32:07 INFO - ##### 14:32:07 INFO - Running pre-action listener: _resource_record_pre_action 14:32:07 INFO - Running main action method: install 14:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:07 INFO - Reading from file tmpfile_stdout 14:32:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:07 INFO - Reading from file tmpfile_stdout 14:32:07 INFO - Output received: 14:32:07 INFO - Usage: mozinstall [options] installer 14:32:07 INFO - Options: 14:32:07 INFO - -h, --help show this help message and exit 14:32:07 INFO - -d DEST, --destination=DEST 14:32:07 INFO - Directory to install application into. [default: 14:32:07 INFO - "/builds/slave/test"] 14:32:07 INFO - --app=APP Application being installed. [default: firefox] 14:32:07 INFO - mkdir: /builds/slave/test/build/application 14:32:07 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'] 14:32:07 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 14:32:23 INFO - Reading from file tmpfile_stdout 14:32:23 INFO - Output received: 14:32:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:23 INFO - Running post-action listener: _resource_record_post_action 14:32:23 INFO - ##### 14:32:23 INFO - ##### Running run-tests step. 14:32:23 INFO - ##### 14:32:23 INFO - Running pre-action listener: _resource_record_pre_action 14:32:23 INFO - Running main action method: run_tests 14:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:23 INFO - Python 2.7.3 14:32:23 INFO - Return code: 0 14:32:23 INFO - grabbing minidump binary from tooltool 14:32:23 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')]} 14:32:23 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 0x2c36410>, '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 0x2c37310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c377a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:23 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 14:32:23 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 14:32:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:23 INFO - Return code: 0 14:32:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:24 INFO - Return code: 0 14:32:24 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/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 14:32:24 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/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 14:32:24 INFO - Using env: {'DISPLAY': ':0', 14:32:24 INFO - 'HOME': '/home/cltbld', 14:32:24 INFO - 'LANG': 'en_US.UTF-8', 14:32:24 INFO - 'LANGUAGE': 'en_US:en', 14:32:24 INFO - 'LOGNAME': 'cltbld', 14:32:24 INFO - 'MAIL': '/var/mail/cltbld', 14:32:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:24 INFO - 'MOZ_NO_REMOTE': '1', 14:32:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:24 INFO - 'NO_EM_RESTART': '1', 14:32:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:24 INFO - 'PWD': '/builds/slave/test', 14:32:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:24 INFO - 'SHELL': '/bin/bash', 14:32:24 INFO - 'SHLVL': '1', 14:32:24 INFO - 'TERM': 'linux', 14:32:24 INFO - 'TMOUT': '86400', 14:32:24 INFO - 'USER': 'cltbld', 14:32:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411', 14:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:24 INFO - '_': '/tools/buildbot/bin/python'} 14:32:24 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/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 14:32:24 INFO - mozversion application_buildid: 20160420141303 14:32:24 INFO - mozversion application_changeset: c1a9497a212d54fda334e9174aac33926196df8e 14:32:24 INFO - mozversion application_display_name: Nightly 14:32:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:24 INFO - mozversion application_name: Firefox 14:32:24 INFO - mozversion application_remotingname: firefox 14:32:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:24 INFO - mozversion application_vendor: Mozilla 14:32:24 INFO - mozversion application_version: 48.0a1 14:32:24 INFO - mozversion platform_buildid: 20160420141303 14:32:24 INFO - mozversion platform_changeset: c1a9497a212d54fda334e9174aac33926196df8e 14:32:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:24 INFO - mozversion platform_version: 48.0a1 14:32:24 INFO - using testdate: 1461187944 14:32:24 INFO - actual date: 1461187944 14:32:24 INFO - starting webserver on 'localhost:41947' 14:32:24 INFO - SUITE-START | Running 2 tests 14:32:24 INFO - TEST-START | dromaeo_css 14:32:24 INFO - operating with platform_type : linux_ 14:32:24 INFO - Initialising browser for dromaeo_css test... 14:32:24 INFO - TEST-INFO | started process 12681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLow6y8/profile http://localhost:41947/getInfo.html) 14:32:28 INFO - PROCESS | 12681 | __metrics Screen width/height:1600/1200 14:32:28 INFO - PROCESS | 12681 | colorDepth:24 14:32:28 INFO - PROCESS | 12681 | Browser inner width/height: 1024/697 14:32:28 INFO - PROCESS | 12681 | __metrics 14:32:30 ERROR - PROCESS | 12681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:32:30 INFO - TEST-INFO | 12681: exit 0 14:32:30 INFO - Browser initialized. 14:32:30 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:30 INFO - TEST-INFO | started process 12760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLow6y8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:42 INFO - PROCESS | 12760 | RSS: Main: 155705344 14:32:42 INFO - PROCESS | 12760 | 14:33:33 INFO - PROCESS | 12760 | 1461188013840 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] 14:35:45 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41947/tests/dromaeo/cssquery-ext.html) 14:35:47 INFO - PROCESS | 12760 | RSS: Main: 259829760 14:35:47 INFO - PROCESS | 12760 | 14:38:49 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-ext.html (next: http://localhost:41947/tests/dromaeo/cssquery-jquery.html) 14:38:50 INFO - PROCESS | 12760 | RSS: Main: 238460928 14:38:50 INFO - PROCESS | 12760 | 14:41:52 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41947/tests/dromaeo/cssquery-mootools.html) 14:41:53 INFO - PROCESS | 12760 | RSS: Main: 233971712 14:41:53 INFO - PROCESS | 12760 | 14:44:55 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41947/tests/dromaeo/cssquery-prototype.html) 14:44:55 INFO - PROCESS | 12760 | RSS: Main: 229265408 14:44:55 INFO - PROCESS | 12760 | 14:47:58 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41947/tests/dromaeo/cssquery-yui.html) 14:47:59 INFO - PROCESS | 12760 | RSS: Main: 215379968 14:47:59 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | Cycle 1(1): loaded http://localhost:41947/tests/dromaeo/cssquery-yui.html (next: http://localhost:41947/tests/dromaeo/cssquery-dojo.html) 14:51:02 INFO - PROCESS | 12760 | RSS: Main: 266571776 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | __start_tp_report 14:51:02 INFO - PROCESS | 12760 | _x_x_mozilla_page_load 14:51:02 INFO - PROCESS | 12760 | _x_x_mozilla_page_load_details 14:51:02 INFO - PROCESS | 12760 | |i|pagename|runs| 14:51:02 INFO - PROCESS | 12760 | |0;dojo.html;2570.087618895292;2639.4721055788837;2645.814792964491;2663.4673065386914;2682.275785537905;4576.54234576543;4678.953210467898;4681.133990211809;4684.929726054112;4698.647601429893;4631.073785242957;4696.671233013691;4769.117713223056;4811.7594120294025;4812.446568644598;4307.978460107703;4337.587929146726;4359.455068116486;4402.339649052636;4412.75729834859;4282.507511636155;4344.152890186415;4416.939934415733;4435.356873253377;4446.1107778444275;4231.407602935591;4307.1601037797645;4365.716228445141;4400.581944715247;4416.293393057112;4245.002424430257;4254.212970600418;4255.234057869582;4258.276093064186;4262.893427664302;4212.262854000568;4242.087951090531;4243.957560424387;4253.51084625269;4288.935665965013;4586.633069354443;4587.288970209623;4618.5381461853885;4634.096351211515;4658.231391820345;5054.3176671149295;5055.51972562606;5057.797688092509;5070.239464080418;5116.513931176532;4885.7312847793355;5035.1188542005;5094.057599344133;5099.71951542665;5111.821086262;4717.834875779331;4726.692764970266;4742.928856067162;4767.380240568704;4768.594669453066;5090.134677104901;5122.590192784568;5143.717095559706;5144.717040562805;5147.433782283946;4757.286407038971;4929;4933.679310844784;4972.801087956514;5063.620228482879;4907;4928.433230178575;4943.90112197754;4948.604111671129;5004.9499505005215;4874.8781280467565;4878.170710979142;4881.487443818419;4884.780184891689;4949.7772600233075;4859.684120532154;4951.282064100757;4951.801927922915;4954;4963.6277279204205;3833.0609000794425;3849.8075096245075;3851.4030325299623;3860.2279544090734;3868.3810590305416;3471.0454624978333;3474.1835668617855;3507.7544571879725;3576.4277715565386;3613.584437789688;4344.761038142869;4348.586884245991;4352.303631419021;4365.170617582649;4401.493828209733;4992.575631071327;5030.522100400456;5063.0380227756605;5064.442911279756;5123.718195499208;4222.113356195172;4316.892077698019;4330;4360.345948107746;4409.5149533551285;4468.530804265571;4487.528809475023;4504.864854054384;4510.954890451119;4542.750148741785;4572.337011133433;4766.547178018082;4772.284157376422;4775.403074615673;4804.42346918372;5024.723640199824;5052.065367906949;5118.181091025418;5120.974395128001;5122.385313762224;4735.076660051394;4785.832495862628;4787.521247875185;4789.736564488987;4830.8792280193275;4786.856394308176;4969.378827646544;4969.950300496948;4973;5017.347744793299;4959.355283813081;4972.950270497394;4992.525710057539;5035.29505869186;5041.7227052511;4855.927161092516;4866.562009419169;4876.024795041077;4876.195427754381;4929.260610908249;4720.929186062281;4860;4861.5659422448;4885;4912.435069966999;4879.609631229564;4894.95105048945;4897.7795999180835;4943.728094954812;4944.456109827988;4989.401271847401;5012.122878496321;5012.248162775612;5017.648764586444;5064.949350506595;4608.170529304623;4645.86062418128;4881.585065269492;4902.3872015998;4952.083864485082 14:51:02 INFO - PROCESS | 12760 | |1;ext.html;576.1271673414775;612.9049997250427;618.9504839612831;628.8899442597544;631.7062565906853;28179.718202817967;29092.418151636954;29151.562726559092;29177.56233656494;33915.830420847924;37558.248835023354;37927;38103;38131.237375252545;38148.61851381485;7458.4033277337685;7659.387249020093;7687.807804804868;7733.033370828646;7740.806479837993;7342.118945726494;7561.886571701429;7672.616369181518;9602.615895364177;10078.848817267746;9625.566849491755;9674.37116587423;9684.22526197906;9692.46691431971;9784.608615655365;9554.187894029015;9666.806663866684;9675.419474831533;9675.758106047335;9683.612655493771;7258.165310989251;9601.663941762004;9863.90136098637;9926.702198934043;9974.800503989953;33503.99488015339;33989;34057.31885362304;34312.31375372504;34427.96716098521;3173.508106243536;3342;3458.515807786912;3519.595246546629;3625.401808701561;26802.195934122006;27129.321766955785;27237.727622723916;27722.168334949984;28833.711662883314;3526.6297038811067;3587.928241435183;3590.317839610492;3667.5598928128798;3718.9442158367647;250657;250959;251115;251189.99999999817;251646;33040.50439243413;33922.49116263258;33969.49045764316;53768.462315377124;54759.726201368736;31814.522782158285;31916.361672766878;31917.20206994844;31945.52081718776;32092.518612220836;12156.878431215751;12340.382980850922;12413;12414.131010829336;12426.813597796041;9799.755006124904;10338.689839304832;10390.896091039143;10465.26743127989;10475.1096156826;8014;8199.057108432487;8267.338612910953;8272.420930534925;8354.415190936576;3129.2802655389387;3228.741700663941;3229.1442767666585;3230.5638738769967;3235.320582677617;839.9076101628816;881.18930583863;946.3281070440065;959.8848138223458;978.1196922769565;25535;26831.329216769736;27011.864940675565;28874.278143046173;30677.539836902466;928.6842473559022;982.9848809939596;985.6402413119304;994.6220436234184;1006.6677996261217;13901.860981390057;14110.153390796586;14468.782968255484;14582.41670333196;14776;346039;353910;354891;355149;355269;46334;47936;48018;48084.5191548087;48190.5180948186;1156.5836298932377;1257.698152443407;1270.307682313123;1274.0953922714975;1289.3875409180564;24747;25531.617025745;27955.860220698767;28060.29849253785;31938.68061319357;46255.76872115618;47263.76368118137;49153.2627010588;49168;49235.26147107868;324165;324332;324758;326923;327869;32963.67036329606;37932;38268.808655957655;39062.6093739059;39771;38366;40436.59563404328;40442.1911561773;41243.1751364977;41259;31869.8406507966;33791.49312760261;34544.48183277203;34985.65014349824;35032.12419689528;34148.82925585356;34263.65736342605;34334.313313734085;34537.309253815285;34763.478547822306;34304.656953430145;34616.48075278822;35142.82428587841;35156.64843351534;35196.47205291974;30386.696133038386;31211.219719507193;31273.530897037017;31528.842355788074;31534.526982094827;23851.284461466184;24369.51260974806;24685.833017002034;24695.38261543476;24968 14:51:02 INFO - PROCESS | 12760 | |2;jquery.html;382.31565497759004;385.974911630744;390.46701252789944;397.3741357362155;403.77792214282135;15037.398504059838;16430.7535386969;17168.914155429236;17169.914150429246;17200.225989830473;15604.453844115458;16368.672626547463;16564.83435165648;16615.252313645884;16697.49907502777;4661.813527458906;4785.521447855222;4813.66304358695;4823.155947709154;4823.34884790554;3486.1284678830293;6421.711023003976;6805.353491418307;6817.352351526597;6829.043933849265;6099.329073801879;6449.83875403114;6794.660266986655;6817.045613614098;6830.6926188321395;6244.1570387997945;6459.6447195404235;6496.837579060538;6518.217813862343;6936.514443988923;6692.364225398579;6701.966490167567;6734.93265067348;6737.3262673732725;6740.696668649874;20994.37016889496;22378.216762413238;23475.530489390287;23500.529989400115;23532.64701029486;2044.6524090904581;2055.732754741889;2067.576146889899;2092.968605470919;2187.9453013674784;13774.862251377559;13988.160710357412;14532.709345813024;14588.197649129293;14725.852741472663;1918.472420084488;1977.8714383565023;1992.8903910284928;2032.7255820464195;2056.9177232910665;81954;85707.5714621423;87521.56239218827;88282.11717882803;88380.55809720975;15132.924335378253;16447.91776041136;16471.423500177436;16499.505014849572;16698.081605511572;29969.700302997127;29983.400331993238;30317.968203179946;30412.54381184284;30424.239394014883;8465.703700370457;8892.822143557092;8933.553322333857;8950.731478055668;9003.684871029482;7182.8204294892;7216.242294558996;7253.891191632129;7385.704571817175;7387.445941554405;6972.895406568906;8106.513609183467;8136.75589732309;8231.34149268057;8253.83492330162;2753.6420265365373;3048.7103725146076;3145.05648305512;3258.918527036843;3364.899053028413;911.8541033434618;918.8989211186764;929.3401684803865;947.9289053321029;978.8140253351983;16031.278592463366;16713.997160170187;16926.23831927566;17153.485395437907;17297.91351043237;416.4648426771584;420.1450049149965;454.87036194684356;862.2713806833216;883.8541640629225;5135.563477104488;5511.614187006951;5602.215689803431;5637.069883469182;5664.660120392789;388666;405788;425541;428368;429540.34136927826;46862;60355;67531;83230.5838470816;83381.16618833735;445.4120560859699;445.72587858466807;447.83653966302717;450.8895320646463;451.1653441133876;9339.112784285482;9466.100720431548;9682.419054856731;9730.75673108178;9748.756281093029;30423.239419014702;30787.230319242197;31748.206294842814;32532.34935301328;32725.18187045343;48929.5107048925;49628.50371496239;49681.484178967825;49742.25386619276;50207.24689129593;7705.961470192613;7833.255840695125;8014.238647328494;8029.959850200712;8132.634031468479;8541.701040463555;10105.242106842163;10938.726531836768;11724.296542207494;11734.41327933617;9862.654807081717;10108.595656173671;10203.642872499428;10403.94798026005;10661.09380702649;10065.597376104874;10101.69694909154;10128.645497407555;10244.334118282288;10259.692209233735;10254.794904102026;10591.099756520782;10592.576296948037;10671;10685.412302323446;7012.088428504262;7833;7978.640961156646;8024.077231118263;8199.754007379788;8361.289290410383;9156.542172891463;9258.398204116711;9497.477638729937;9778.315517913677 14:51:02 INFO - PROCESS | 12760 | |3;mootools.html;1263.5135472842953;1429.5282556756267;1458.7228426598945;1595.1306537936823;1790.0781097734668;6748.426383757381;7602.961985190073;7790.065192176947;7807.375409967203;7822.335101516371;7700.576468294242;7893.934318866951;7899.486533375327;7902.762917112482;7912;1911.0540282560082;2164.5021645021575;2249.089118906845;2249.5388445368744;2258.627326491127;2266.2294819761278;2273;2286.3598192506124;2288.8855557222155;2291.679164916913;2219.212179676208;2263.0721404224273;2263.366257447917;2267.501149747053;2269.387265438331;1895.753552038233;2176.8040876321206;2254.6054440472853;2261.2198791416936;2262.5022495051226;2118.120979793384;2118.311548746648;2130.3076500137363;2135.4341099608614;2165.675148727688;7644.503107298064;7659.119201291811;7707.421943354215;7717.768466946;7733.961330193313;4489.955100448987;4630.374899388573;4634.814607415699;4651.209294419957;4698.929516057262;3051.7406020488284;3062.5099984002454;3114.2370119320685;3155.3373791503814;3159.162821852211;919.1314208073373;920.9309301802392;936.2743873498025;942.8350038743262;945.938513996588;10781.245312828105;10783.029527342576;10806.459677016117;10818.459077046116;10826.24216304859;4255.97872010638;4284.721493103;4413.492448368479;4435.068635586563;4460.620847227957;8290.958545207235;8431.95784021076;8436.325093992466;8440.11378805229;8449.915500845036;4095.3856921461424;4673.158831410379;4707.576318131385;4713.505081966413;4724.078804633133;4324.2648749712625;4385.386045953569;4406.471223453142;4410.823567057282;4427.424434823452;3356.328734253159;3383.5263063171174;3441.587009558869;3472.1840367513614;3508.245727168671;1076.1713480619878;1087.7878813631266;1090.536521978156;1091.6724982505216;1093.059968427152;738.0442327186306;831.6881169561415;898.7213963671282;899.0739538275586;938.1041105743998;5165.302684137669;5378.838634840883;5392.595555333366;5493.258410114583;5520.199571062254;881.4755220643707;924.2929159193222;930.0374112793362;934.3552948465536;954.7517645412104;3812.2184952085313;3924.803759811998;3925.2542017016676;3931.056546428894;4016.216837716617;9027.909720902839;9206.953965230132;9215.53922303882;9400.90599094014;9402.15380615748;9205.217556507638;9341.626334946663;9372.62509499626;9377.43735375866;9409.482478463613;7313.122425308997;7343.706251749977;7464.626768661546;7546.698132074765;7568.810779730441;5496.340439147328;5511.641743286674;5575.721213939368;5633.464820842013;5637.154426835843;8810.86783698258;8815.426997245158;8928.642854286016;9019.143181397756;9020.548972551214;9159.908400915905;9270.953645231732;9281.582328795086;9300.860487092563;9377.202937750095;5815.738291776965;6191.7523299069335;6326.43062124411;6460.3862633049785;6574.211094668671;7456.888146677696;7508.624568771649;7539.359154471712;7541.2458754124145;7554.886676699964;6529.118568993125;6687.164104486939;6720.260771315249;6870.20992585839;6927.965360173167;6494.603660213077;6506.837329066811;6546.901796473152;6708.597484150967;6788.59268443895;6466.127072845105;6500.284968653539;6511.34886511345;6527.379898909596;6531.281559028598;4611.146937816515;4686.109639168547;4772.809087636456;4791.856244312677;4806.206975849085;4769.689970152068;4799.064182484522;4863.781129849094;4932.556069953578;4960.677555958851 14:51:02 INFO - PROCESS | 12760 | |4;prototype.html;312.5920673521054;314.08287799625094;316.1416753514209;318.2298836814906;319.10013761193443;5112.48875112489;5123.77029512917;5124.231365295208;5146;5196.350456192976;5072.61587054084;5093.363329583802;5102.1836506158925;5103.41310749263;5116.8976620467565;3784.924301513968;3874.496315478984;3903.8048097595147;4009.5990400959963;4032.9395059074136;3965.940510892339;3968.9801550992206;3980.9203815923665;4011.7994100295014;4022.35642297231;3755.906102347436;3951.960480395188;3954.268460334847;3962.1877515109477;3987.940180897289;3873.4577159197593;3966.1472783351574;3991.1419044905197;3991.1618560102415;3994.320965435883;3505.5793304803333;3513.437849944022;3515.7187425005936;3532.8056956867363;3549.2546565221332;4863.416390033183;4878;4912.533309335608;4928.605711543104;4932.260160975847;4359.738415695068;4583.197940360424;4595.448546174481;4602.539746025404;4624.884377890546;5406.432324605899;5415.377231618375;5421.674699518002;5437.238786569884;5437.537809286216;3920.2551515212017;3932.449457075983;3939.527256729182;3940.862069827571;3943.861964831217;5545.112781954908;5649.887002259973;5680.40948534411;5682.119271512881;5692.231548740909;3985.083430810872;4005.118873847749;4012.7391719538136;4014.1770936957855;4017.417474466186;4063.329550624114;4074.4703188585295;4075.470188875427;4075.91848163041;4077.7145599807727;4533.297338912474;4537.682362234612;4612.400387949545;4617.953820461752;4630.583247507673;5395.757190926418;5398.46015398457;5409.945900541023;5411.107167317348;5415.512603865593;1404.890136791923;1424.9572512824632;1427.1579767936967;1430.985690143106;1434.7489189391815;924.3252425729121;949.4730424614268;978.188103873783;986.837171866634;1001.3341128149699;4700.482946875841;4703.412073490814;4705.858824235278;4708;4721.95278047222;5476.616636835463;5477.068898287301;5480.698561579072;5483.533899618497;5498.230247765316;4561.771911404483;4635.814567417266;4701.48283688794;4718.905621887543;4799.352087468217;2960.1119664100684;2972.1677930179585;2991.1624745071413;2998.370342228113;3003.4443627928904;5262.368515778131;5270.420253772082;5280.709560974106;5284.365876094893;5314.840554783363;5522.475364840334;5718.256626638594;5722.712389712281;5730.106296320331;5744.856378590485;5257.78968841242;5269.420363759983;5275.815346462932;5282.811367442295;5286.788528458896;5444.945550544444;5543.667379957215;5594.888102237851;5600.747966341443;5609.635373700697;5484.698341591251;5500.367457742251;5502.779888804403;5511.559075273888;5538.196961440649;5270.260813931317;5270.736463176902;5286.15421532553;5289.894202116013;5304.204369344475;3769.962300376961;3888.125171836314;3890.4747859038666;3891.416287556889;3903.341080041028;5531.419200984;5563;5601.775928962796;5608.523275521627;5613.326400831927;5425.321834770653;5428.565714742732;5442.965836491054;5444.673319600836;5463.453654634504;5298.523132918056;5426.8100616479815;5431.565474762088;5446.237526746179;5450.645708029124;5055.898882022266;5317.468253174651;5326.6537675050995;5338.065838478173;5354.3574771027725;5173.793048278027;5342.519173274424;5348.679079255257;5351.063563876384;5351.394581625575;5274.314339135888;5278.340207474066;5286.524212820865;5287.894242115213;5292.9735351323 14:51:02 INFO - PROCESS | 12760 | |5;yui.html;750.4634186556611;761.1437133225122;777.1839568453123;780.5628847845207;786.5988345943571;11365.602203922865;11633.941830290836;11667.59163429278;11672.416379181039;11690;11213.439328033586;11238.606648767294;11247.325160490356;11268.774624507505;11337.036351910097;644.2880616918308;780.9531428114303;784.5920121536798;804.4650307545476;815.0708192660372;802.7270727952495;803.1887793328722;805.8670319397322;806.3146325623233;806.770070529899;849.3672214200429;852.7910661887846;853.5220276645099;853.9146085391442;854.4958474500044;667.4893706314649;826.8842362069315;848.707196017373;849.8725191221366;850.685246458808;628.0391001767304;628.2994461175756;629.361198383641;629.3832044596276;629.7166275176144;11747.765044699143;11813.173077884465;11817.290962542274;11819.940900295529;11850.822237666442;11849.94075029628;12297.815532767016;12643.241405515606;12651.810222846665;13041.217526948414;11166.162537809616;11447.313161210353;11501.42492875353;11510;11726.003289720384;3270.9815926529554;3318.502224666295;3346.364190803764;3381.8647254109806;3450.344434557451;45077.323840142424;47396;48784.26823597649;48824.511754882355;49103.26345104826;9929.304948653526;10081.69754907354;10147.492625368703;10152.593896244067;10186.64346747875;17524;17556.122193890253;17581.7362739559;17582;17598.736018959728;6969.6515174241085;7006.264342244093;7064.823379415453;7088.291170882871;7208.207097219301;3818.713596480275;3853.9229215416094;3862.2854771867296;3866.3620502616754;3908.1206728485863;2954.9409011819644;3049.344390955955;3049.4053659536175;3049.9390012199633;3053.64883038449;478.44022493682473;479.1997364401458;501.29567957020447;504.8182654244469;516.3571353664712;538.1765898175797;550.9614426621516;608.4888693497484;615.7167702856647;624.709510077816;8045.15525869787;8108.472949258279;8147.75556733299;8199.508029518249;8262.082710513203;511.7620306557394;521.0802932823569;593.9316978547522;614.1555361378105;618.6500101947902;3765.246950609889;3905.882823515299;3912.56961734209;3926.9214615707524;3963.722539422213;57277.427225728046;58894.822103557686;59491;60022.29899654526;60238;50307.49692503028;51073.48926510687;51716;52425.2136217957;52427.73786131045;46611.30083048757;46839.765801170775;47048;47189.29216061762;47643;7324;7458.328750412489;7475.36459400957;7483.214262502359;7625.268006035081;30247.546286805275;30459.543106852972;30849.691503085578;31224;31464;29486.557701634065;33435.164120896196;33546.988359199524;37064.25871482501;37146.44280335851;10423.478826058516;10454.529546170592;10581.36511809294;10649.574017039231;10763.623273185714;9024.36829421934;11579.478923448634;11714.941425292818;11913.761724765629;12010.63968080959;10642.467876606293;11143.2199746017;11162.274452160584;11621.12841536905;11664.183507154417;11261.66215013551;11303.265287756269;11382.943085284853;11537.769244615229;11857.644270671894;10981.945090274497;11131;11270.94364528172;11418.543258269576;11669.416529173677;9047.230985366317;9208.861867072133;9319.906800931903;9424.670136545188;9700.07849254348;8999.685011024583;9276.11876871696;9342.906570934203;9371.203447706748;9471 14:51:02 INFO - PROCESS | 12760 | __end_tp_report 14:51:02 INFO - PROCESS | 12760 | __start_cc_report 14:51:02 INFO - PROCESS | 12760 | _x_x_mozilla_cycle_collect,973 14:51:02 INFO - PROCESS | 12760 | __end_cc_report 14:51:02 INFO - PROCESS | 12760 | __startTimestamp1461189062440__endTimestamp 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | ------- Summary: start ------- 14:51:02 INFO - PROCESS | 12760 | Number of tests: 6 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#0] dojo.html Cycles:165 Average:4624.33 Median:4785.83 stddev:511.40 (10.7%) stddev-sans-first:486.92 14:51:02 INFO - PROCESS | 12760 | Values: 2570.1 2639.5 2645.8 2663.5 2682.3 4576.5 4679.0 4681.1 4684.9 4698.6 4631.1 4696.7 4769.1 4811.8 4812.4 4308.0 4337.6 4359.5 4402.3 4412.8 4282.5 4344.2 4416.9 4435.4 4446.1 4231.4 4307.2 4365.7 4400.6 4416.3 4245.0 4254.2 4255.2 4258.3 4262.9 4212.3 4242.1 4244.0 4253.5 4288.9 4586.6 4587.3 4618.5 4634.1 4658.2 5054.3 5055.5 5057.8 5070.2 5116.5 4885.7 5035.1 5094.1 5099.7 5111.8 4717.8 4726.7 4742.9 4767.4 4768.6 5090.1 5122.6 5143.7 5144.7 5147.4 4757.3 4929.0 4933.7 4972.8 5063.6 4907.0 4928.4 4943.9 4948.6 5004.9 4874.9 4878.2 4881.5 4884.8 4949.8 4859.7 4951.3 4951.8 4954.0 4963.6 3833.1 3849.8 3851.4 3860.2 3868.4 3471.0 3474.2 3507.8 3576.4 3613.6 4344.8 4348.6 4352.3 4365.2 4401.5 4992.6 5030.5 5063.0 5064.4 5123.7 4222.1 4316.9 4330.0 4360.3 4409.5 4468.5 4487.5 4504.9 4511.0 4542.8 4572.3 4766.5 4772.3 4775.4 4804.4 5024.7 5052.1 5118.2 5121.0 5122.4 4735.1 4785.8 4787.5 4789.7 4830.9 4786.9 4969.4 4970.0 4973.0 5017.3 4959.4 4973.0 4992.5 5035.3 5041.7 4855.9 4866.6 4876.0 4876.2 4929.3 4720.9 4860.0 4861.6 4885.0 4912.4 4879.6 4895.0 4897.8 4943.7 4944.5 4989.4 5012.1 5012.2 5017.6 5064.9 4608.2 4645.9 4881.6 4902.4 4952.1 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#1] ext.html Cycles:180 Average:45151.62 Median:174748.76 stddev:82352.95 (47.1%) stddev-sans-first:82515.96 14:51:02 INFO - PROCESS | 12760 | Values: 576.1 612.9 619.0 628.9 631.7 28179.7 29092.4 29151.6 29177.6 33915.8 37558.2 37927.0 38103.0 38131.2 38148.6 7458.4 7659.4 7687.8 7733.0 7740.8 7342.1 7561.9 7672.6 9602.6 10078.8 9625.6 9674.4 9684.2 9692.5 9784.6 9554.2 9666.8 9675.4 9675.8 9683.6 7258.2 9601.7 9863.9 9926.7 9974.8 33504.0 33989.0 34057.3 34312.3 34428.0 3173.5 3342.0 3458.5 3519.6 3625.4 26802.2 27129.3 27237.7 27722.2 28833.7 3526.6 3587.9 3590.3 3667.6 3718.9 250657.0 250959.0 251115.0 251190.0 251646.0 33040.5 33922.5 33969.5 53768.5 54759.7 31814.5 31916.4 31917.2 31945.5 32092.5 12156.9 12340.4 12413.0 12414.1 12426.8 9799.8 10338.7 10390.9 10465.3 10475.1 8014.0 8199.1 8267.3 8272.4 8354.4 3129.3 3228.7 3229.1 3230.6 3235.3 839.9 881.2 946.3 959.9 978.1 25535.0 26831.3 27011.9 28874.3 30677.5 928.7 983.0 985.6 994.6 1006.7 13901.9 14110.2 14468.8 14582.4 14776.0 346039.0 353910.0 354891.0 355149.0 355269.0 46334.0 47936.0 48018.0 48084.5 48190.5 1156.6 1257.7 1270.3 1274.1 1289.4 24747.0 25531.6 27955.9 28060.3 31938.7 46255.8 47263.8 49153.3 49168.0 49235.3 324165.0 324332.0 324758.0 326923.0 327869.0 32963.7 37932.0 38268.8 39062.6 39771.0 38366.0 40436.6 40442.2 41243.2 41259.0 31869.8 33791.5 34544.5 34985.7 35032.1 34148.8 34263.7 34334.3 34537.3 34763.5 34304.7 34616.5 35142.8 35156.6 35196.5 30386.7 31211.2 31273.5 31528.8 31534.5 23851.3 24369.5 24685.8 24695.4 24968.0 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#2] jquery.html Cycles:180 Average:25857.65 Median:453.02 stddev:68622.43 (15147.8%) stddev-sans-first:68788.27 14:51:02 INFO - PROCESS | 12760 | Values: 382.3 386.0 390.5 397.4 403.8 15037.4 16430.8 17168.9 17169.9 17200.2 15604.5 16368.7 16564.8 16615.3 16697.5 4661.8 4785.5 4813.7 4823.2 4823.3 3486.1 6421.7 6805.4 6817.4 6829.0 6099.3 6449.8 6794.7 6817.0 6830.7 6244.2 6459.6 6496.8 6518.2 6936.5 6692.4 6702.0 6734.9 6737.3 6740.7 20994.4 22378.2 23475.5 23500.5 23532.6 2044.7 2055.7 2067.6 2093.0 2187.9 13774.9 13988.2 14532.7 14588.2 14725.9 1918.5 1977.9 1992.9 2032.7 2056.9 81954.0 85707.6 87521.6 88282.1 88380.6 15132.9 16447.9 16471.4 16499.5 16698.1 29969.7 29983.4 30318.0 30412.5 30424.2 8465.7 8892.8 8933.6 8950.7 9003.7 7182.8 7216.2 7253.9 7385.7 7387.4 6972.9 8106.5 8136.8 8231.3 8253.8 2753.6 3048.7 3145.1 3258.9 3364.9 911.9 918.9 929.3 947.9 978.8 16031.3 16714.0 16926.2 17153.5 17297.9 416.5 420.1 454.9 862.3 883.9 5135.6 5511.6 5602.2 5637.1 5664.7 388666.0 405788.0 425541.0 428368.0 429540.3 46862.0 60355.0 67531.0 83230.6 83381.2 445.4 445.7 447.8 450.9 451.2 9339.1 9466.1 9682.4 9730.8 9748.8 30423.2 30787.2 31748.2 32532.3 32725.2 48929.5 49628.5 49681.5 49742.3 50207.2 7706.0 7833.3 8014.2 8030.0 8132.6 8541.7 10105.2 10938.7 11724.3 11734.4 9862.7 10108.6 10203.6 10403.9 10661.1 10065.6 10101.7 10128.6 10244.3 10259.7 10254.8 10591.1 10592.6 10671.0 10685.4 7012.1 7833.0 7978.6 8024.1 8199.8 8361.3 9156.5 9258.4 9497.5 9778.3 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#3] mootools.html Cycles:180 Average:5153.47 Median:5515.92 stddev:2822.45 (51.2%) stddev-sans-first:2815.23 14:51:02 INFO - PROCESS | 12760 | Values: 1263.5 1429.5 1458.7 1595.1 1790.1 6748.4 7603.0 7790.1 7807.4 7822.3 7700.6 7893.9 7899.5 7902.8 7912.0 1911.1 2164.5 2249.1 2249.5 2258.6 2266.2 2273.0 2286.4 2288.9 2291.7 2219.2 2263.1 2263.4 2267.5 2269.4 1895.8 2176.8 2254.6 2261.2 2262.5 2118.1 2118.3 2130.3 2135.4 2165.7 7644.5 7659.1 7707.4 7717.8 7734.0 4490.0 4630.4 4634.8 4651.2 4698.9 3051.7 3062.5 3114.2 3155.3 3159.2 919.1 920.9 936.3 942.8 945.9 10781.2 10783.0 10806.5 10818.5 10826.2 4256.0 4284.7 4413.5 4435.1 4460.6 8291.0 8432.0 8436.3 8440.1 8449.9 4095.4 4673.2 4707.6 4713.5 4724.1 4324.3 4385.4 4406.5 4410.8 4427.4 3356.3 3383.5 3441.6 3472.2 3508.2 1076.2 1087.8 1090.5 1091.7 1093.1 738.0 831.7 898.7 899.1 938.1 5165.3 5378.8 5392.6 5493.3 5520.2 881.5 924.3 930.0 934.4 954.8 3812.2 3924.8 3925.3 3931.1 4016.2 9027.9 9207.0 9215.5 9400.9 9402.2 9205.2 9341.6 9372.6 9377.4 9409.5 7313.1 7343.7 7464.6 7546.7 7568.8 5496.3 5511.6 5575.7 5633.5 5637.2 8810.9 8815.4 8928.6 9019.1 9020.5 9159.9 9271.0 9281.6 9300.9 9377.2 5815.7 6191.8 6326.4 6460.4 6574.2 7456.9 7508.6 7539.4 7541.2 7554.9 6529.1 6687.2 6720.3 6870.2 6928.0 6494.6 6506.8 6546.9 6708.6 6788.6 6466.1 6500.3 6511.3 6527.4 6531.3 4611.1 4686.1 4772.8 4791.9 4806.2 4769.7 4799.1 4863.8 4932.6 4960.7 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#4] prototype.html Cycles:180 Average:4484.45 Median:5107.95 stddev:1297.21 (25.4%) stddev-sans-first:1262.49 14:51:02 INFO - PROCESS | 12760 | Values: 312.6 314.1 316.1 318.2 319.1 5112.5 5123.8 5124.2 5146.0 5196.4 5072.6 5093.4 5102.2 5103.4 5116.9 3784.9 3874.5 3903.8 4009.6 4032.9 3965.9 3969.0 3980.9 4011.8 4022.4 3755.9 3952.0 3954.3 3962.2 3987.9 3873.5 3966.1 3991.1 3991.2 3994.3 3505.6 3513.4 3515.7 3532.8 3549.3 4863.4 4878.0 4912.5 4928.6 4932.3 4359.7 4583.2 4595.4 4602.5 4624.9 5406.4 5415.4 5421.7 5437.2 5437.5 3920.3 3932.4 3939.5 3940.9 3943.9 5545.1 5649.9 5680.4 5682.1 5692.2 3985.1 4005.1 4012.7 4014.2 4017.4 4063.3 4074.5 4075.5 4075.9 4077.7 4533.3 4537.7 4612.4 4618.0 4630.6 5395.8 5398.5 5409.9 5411.1 5415.5 1404.9 1425.0 1427.2 1431.0 1434.7 924.3 949.5 978.2 986.8 1001.3 4700.5 4703.4 4705.9 4708.0 4722.0 5476.6 5477.1 5480.7 5483.5 5498.2 4561.8 4635.8 4701.5 4718.9 4799.4 2960.1 2972.2 2991.2 2998.4 3003.4 5262.4 5270.4 5280.7 5284.4 5314.8 5522.5 5718.3 5722.7 5730.1 5744.9 5257.8 5269.4 5275.8 5282.8 5286.8 5444.9 5543.7 5594.9 5600.7 5609.6 5484.7 5500.4 5502.8 5511.6 5538.2 5270.3 5270.7 5286.2 5289.9 5304.2 3770.0 3888.1 3890.5 3891.4 3903.3 5531.4 5563.0 5601.8 5608.5 5613.3 5425.3 5428.6 5443.0 5444.7 5463.5 5298.5 5426.8 5431.6 5446.2 5450.6 5055.9 5317.5 5326.7 5338.1 5354.4 5173.8 5342.5 5348.7 5351.1 5351.4 5274.3 5278.3 5286.5 5287.9 5293.0 14:51:02 INFO - PROCESS | 12760 | 14:51:02 INFO - PROCESS | 12760 | [#5] yui.html Cycles:180 Average:13182.31 Median:46943.88 stddev:15559.85 (33.1%) stddev-sans-first:15575.49 14:51:02 INFO - PROCESS | 12760 | Values: 750.5 761.1 777.2 780.6 786.6 11365.6 11633.9 11667.6 11672.4 11690.0 11213.4 11238.6 11247.3 11268.8 11337.0 644.3 781.0 784.6 804.5 815.1 802.7 803.2 805.9 806.3 806.8 849.4 852.8 853.5 853.9 854.5 667.5 826.9 848.7 849.9 850.7 628.0 628.3 629.4 629.4 629.7 11747.8 11813.2 11817.3 11819.9 11850.8 11849.9 12297.8 12643.2 12651.8 13041.2 11166.2 11447.3 11501.4 11510.0 11726.0 3271.0 3318.5 3346.4 3381.9 3450.3 45077.3 47396.0 48784.3 48824.5 49103.3 9929.3 10081.7 10147.5 10152.6 10186.6 17524.0 17556.1 17581.7 17582.0 17598.7 6969.7 7006.3 7064.8 7088.3 7208.2 3818.7 3853.9 3862.3 3866.4 3908.1 2954.9 3049.3 3049.4 3049.9 3053.6 478.4 479.2 501.3 504.8 516.4 538.2 551.0 608.5 615.7 624.7 8045.2 8108.5 8147.8 8199.5 8262.1 511.8 521.1 593.9 614.2 618.7 3765.2 3905.9 3912.6 3926.9 3963.7 57277.4 58894.8 59491.0 60022.3 60238.0 50307.5 51073.5 51716.0 52425.2 52427.7 46611.3 46839.8 47048.0 47189.3 47643.0 7324.0 7458.3 7475.4 7483.2 7625.3 30247.5 30459.5 30849.7 31224.0 31464.0 29486.6 33435.2 33547.0 37064.3 37146.4 10423.5 10454.5 10581.4 10649.6 10763.6 9024.4 11579.5 11714.9 11913.8 12010.6 10642.5 11143.2 11162.3 11621.1 11664.2 11261.7 11303.3 11382.9 11537.8 11857.6 10981.9 11131.0 11270.9 11418.5 11669.4 9047.2 9208.9 9319.9 9424.7 9700.1 8999.7 9276.1 9342.9 9371.2 9471.0 14:51:02 INFO - PROCESS | 12760 | -------- Summary: end -------- 14:51:02 INFO - PROCESS | 12760 | 14:51:03 INFO - TEST-INFO | 12760: exit 0 14:51:03 INFO - TEST-OK | dromaeo_css | took 1118812ms 14:51:03 INFO - TEST-START | kraken 14:51:03 INFO - operating with platform_type : linux_ 14:51:03 INFO - Initialising browser for kraken test... 14:51:03 INFO - TEST-INFO | started process 12940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcfHVg/profile http://localhost:41947/getInfo.html) 14:51:07 INFO - PROCESS | 12940 | __metrics Screen width/height:1600/1200 14:51:07 INFO - PROCESS | 12940 | colorDepth:24 14:51:07 INFO - PROCESS | 12940 | Browser inner width/height: 1024/697 14:51:07 INFO - PROCESS | 12940 | __metrics 14:51:08 ERROR - PROCESS | 12940 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:51:09 INFO - TEST-INFO | 12940: exit 0 14:51:09 INFO - Browser initialized. 14:51:09 INFO - Running cycle 1/1 for kraken test... 14:51:09 INFO - TEST-INFO | started process 13025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcfHVg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:21 INFO - PROCESS | 13025 | RSS: Main: 155570176 14:51:21 INFO - PROCESS | 13025 | 14:51:24 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41947/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:25 INFO - PROCESS | 13025 | RSS: Main: 209264640 14:51:25 INFO - PROCESS | 13025 | 14:51:28 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41947/tests/kraken/driver.html?testName=audio-dft) 14:51:28 INFO - PROCESS | 13025 | RSS: Main: 196255744 14:51:28 INFO - PROCESS | 13025 | 14:51:31 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41947/tests/kraken/driver.html?testName=audio-fft) 14:51:32 INFO - PROCESS | 13025 | RSS: Main: 266326016 14:51:32 INFO - PROCESS | 13025 | 14:51:34 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41947/tests/kraken/driver.html?testName=audio-oscillator) 14:51:35 INFO - PROCESS | 13025 | RSS: Main: 174379008 14:51:35 INFO - PROCESS | 13025 | 14:51:37 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:38 INFO - PROCESS | 13025 | RSS: Main: 178515968 14:51:38 INFO - PROCESS | 13025 | 14:51:41 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41947/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:41 INFO - PROCESS | 13025 | RSS: Main: 215298048 14:51:41 INFO - PROCESS | 13025 | 14:51:45 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41947/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:45 INFO - PROCESS | 13025 | RSS: Main: 214929408 14:51:45 INFO - PROCESS | 13025 | 14:51:48 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41947/tests/kraken/driver.html?testName=json-parse-financial) 14:51:49 INFO - PROCESS | 13025 | RSS: Main: 216420352 14:51:49 INFO - PROCESS | 13025 | 14:51:51 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:51 INFO - PROCESS | 13025 | RSS: Main: 202665984 14:51:51 INFO - PROCESS | 13025 | 14:51:53 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:54 INFO - PROCESS | 13025 | RSS: Main: 206426112 14:51:54 INFO - PROCESS | 13025 | 14:51:56 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:57 INFO - PROCESS | 13025 | RSS: Main: 219054080 14:51:57 INFO - PROCESS | 13025 | 14:51:59 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:00 INFO - PROCESS | 13025 | RSS: Main: 226381824 14:52:00 INFO - PROCESS | 13025 | 14:52:03 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:03 INFO - PROCESS | 13025 | RSS: Main: 219979776 14:52:03 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:41947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41947/tests/kraken/driver.html?testName=ai-astar) 14:52:05 INFO - PROCESS | 13025 | RSS: Main: 283549696 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | __start_tp_report 14:52:05 INFO - PROCESS | 13025 | _x_x_mozilla_page_load 14:52:05 INFO - PROCESS | 13025 | _x_x_mozilla_page_load_details 14:52:05 INFO - PROCESS | 13025 | |i|pagename|runs| 14:52:05 INFO - PROCESS | 13025 | |0;ai-astar;113;115;108;111;114;115;104;112;112;112 14:52:05 INFO - PROCESS | 13025 | |1;audio-beat-detection;165;134;154;180;132;166;162;145;205;131 14:52:05 INFO - PROCESS | 13025 | |2;audio-dft;160;161;160;162;161;161;162;161;164;162 14:52:05 INFO - PROCESS | 13025 | |3;audio-fft;77;74;112;109;75;74;73;111;99;74 14:52:05 INFO - PROCESS | 13025 | |4;audio-oscillator;95;95;151;95;101;93;139;95;94;147 14:52:05 INFO - PROCESS | 13025 | |5;imaging-gaussian-blur;117;116;116;116;116;116;117;116;117;117 14:52:05 INFO - PROCESS | 13025 | |6;imaging-darkroom;146;146;146;146;146;147;147;146;146;145 14:52:05 INFO - PROCESS | 13025 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;95;94 14:52:05 INFO - PROCESS | 13025 | |8;json-parse-financial;64;65;65;64;65;65;66;88;75;62 14:52:05 INFO - PROCESS | 13025 | |9;json-stringify-tinderbox;65;64;65;64;65;65;65;65;64;65 14:52:05 INFO - PROCESS | 13025 | |10;stanford-crypto-aes;80;86;79;80;79;80;82;80;81;82 14:52:05 INFO - PROCESS | 13025 | |11;stanford-crypto-ccm;140;133;134;132;131;144;132;140;165;131 14:52:05 INFO - PROCESS | 13025 | |12;stanford-crypto-pbkdf2;178;173;176;177;174;172;174;172;173;171 14:52:05 INFO - PROCESS | 13025 | |13;stanford-crypto-sha256-iterative;75;73;72;72;77;71;71;72;70;72 14:52:05 INFO - PROCESS | 13025 | __end_tp_report 14:52:05 INFO - PROCESS | 13025 | __start_cc_report 14:52:05 INFO - PROCESS | 13025 | _x_x_mozilla_cycle_collect,1881 14:52:05 INFO - PROCESS | 13025 | __end_cc_report 14:52:05 INFO - PROCESS | 13025 | __startTimestamp1461189125953__endTimestamp 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | ------- Summary: start ------- 14:52:05 INFO - PROCESS | 13025 | Number of tests: 14 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.37 (3.0%) stddev-sans-first:3.54 14:52:05 INFO - PROCESS | 13025 | Values: 113.0 115.0 108.0 111.0 114.0 115.0 104.0 112.0 112.0 112.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:163.50 stddev:23.53 (14.4%) stddev-sans-first:24.80 14:52:05 INFO - PROCESS | 13025 | Values: 165.0 134.0 154.0 180.0 132.0 166.0 162.0 145.0 205.0 131.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.13 14:52:05 INFO - PROCESS | 13025 | Values: 160.0 161.0 160.0 162.0 161.0 161.0 162.0 161.0 164.0 162.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:17.54 (23.7%) stddev-sans-first:18.17 14:52:05 INFO - PROCESS | 13025 | Values: 77.0 74.0 112.0 109.0 75.0 74.0 73.0 111.0 99.0 74.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.50 stddev:24.53 (26.0%) stddev-sans-first:25.37 14:52:05 INFO - PROCESS | 13025 | Values: 95.0 95.0 151.0 95.0 101.0 93.0 139.0 95.0 94.0 147.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:52:05 INFO - PROCESS | 13025 | Values: 117.0 116.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:52:05 INFO - PROCESS | 13025 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 145.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:52:05 INFO - PROCESS | 13025 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:65.00 stddev:7.87 (12.1%) stddev-sans-first:8.22 14:52:05 INFO - PROCESS | 13025 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 66.0 88.0 75.0 62.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:52:05 INFO - PROCESS | 13025 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.08 (2.6%) stddev-sans-first:2.18 14:52:05 INFO - PROCESS | 13025 | Values: 80.0 86.0 79.0 80.0 79.0 80.0 82.0 80.0 81.0 82.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:137.00 stddev:10.45 (7.6%) stddev-sans-first:11.07 14:52:05 INFO - PROCESS | 13025 | Values: 140.0 133.0 134.0 132.0 131.0 144.0 132.0 140.0 165.0 131.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.00 stddev:2.31 (1.3%) stddev-sans-first:1.94 14:52:05 INFO - PROCESS | 13025 | Values: 178.0 173.0 176.0 177.0 174.0 172.0 174.0 172.0 173.0 171.0 14:52:05 INFO - PROCESS | 13025 | 14:52:05 INFO - PROCESS | 13025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:2.07 (2.9%) stddev-sans-first:1.99 14:52:05 INFO - PROCESS | 13025 | Values: 75.0 73.0 72.0 72.0 77.0 71.0 71.0 72.0 70.0 72.0 14:52:05 INFO - PROCESS | 13025 | -------- Summary: end -------- 14:52:05 INFO - PROCESS | 13025 | 14:52:06 INFO - TEST-INFO | 13025: exit 0 14:52:06 INFO - TEST-OK | kraken | took 63707ms 14:52:06 INFO - SUITE-END | took 1182s 14:52:07 INFO - Completed test suite (00:19:42) 14:52:07 INFO - javascript benchmark 14:52:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.087618895292, 2639.4721055788837, 2645.814792964491, 2663.4673065386914, 2682.275785537905, 4576.54234576543, 4678.953210467898, 4681.133990211809, 4684.929726054112, 4698.647601429893, 4631.073785242957, 4696.671233013691, 4769.117713223056, 4811.7594120294025, 4812.446568644598, 4307.978460107703, 4337.587929146726, 4359.455068116486, 4402.339649052636, 4412.75729834859, 4282.507511636155, 4344.152890186415, 4416.939934415733, 4435.356873253377, 4446.1107778444275, 4231.407602935591, 4307.1601037797645, 4365.716228445141, 4400.581944715247, 4416.293393057112, 4245.002424430257, 4254.212970600418, 4255.234057869582, 4258.276093064186, 4262.893427664302, 4212.262854000568, 4242.087951090531, 4243.957560424387, 4253.51084625269, 4288.935665965013, 4586.633069354443, 4587.288970209623, 4618.5381461853885, 4634.096351211515, 4658.231391820345, 5054.3176671149295, 5055.51972562606, 5057.797688092509, 5070.239464080418, 5116.513931176532, 4885.7312847793355, 5035.1188542005, 5094.057599344133, 5099.71951542665, 5111.821086262, 4717.834875779331, 4726.692764970266, 4742.928856067162, 4767.380240568704, 4768.594669453066, 5090.134677104901, 5122.590192784568, 5143.717095559706, 5144.717040562805, 5147.433782283946, 4757.286407038971, 4929.0, 4933.679310844784, 4972.801087956514, 5063.620228482879, 4907.0, 4928.433230178575, 4943.90112197754, 4948.604111671129, 5004.9499505005215, 4874.8781280467565, 4878.170710979142, 4881.487443818419, 4884.780184891689, 4949.7772600233075, 4859.684120532154, 4951.282064100757, 4951.801927922915, 4954.0, 4963.6277279204205, 3833.0609000794425, 3849.8075096245075, 3851.4030325299623, 3860.2279544090734, 3868.3810590305416, 3471.0454624978333, 3474.1835668617855, 3507.7544571879725, 3576.4277715565386, 3613.584437789688, 4344.761038142869, 4348.586884245991, 4352.303631419021, 4365.170617582649, 4401.493828209733, 4992.575631071327, 5030.522100400456, 5063.0380227756605, 5064.442911279756, 5123.718195499208, 4222.113356195172, 4316.892077698019, 4330.0, 4360.345948107746, 4409.5149533551285, 4468.530804265571, 4487.528809475023, 4504.864854054384, 4510.954890451119, 4542.750148741785, 4572.337011133433, 4766.547178018082, 4772.284157376422, 4775.403074615673, 4804.42346918372, 5024.723640199824, 5052.065367906949, 5118.181091025418, 5120.974395128001, 5122.385313762224, 4735.076660051394, 4785.832495862628, 4787.521247875185, 4789.736564488987, 4830.8792280193275, 4786.856394308176, 4969.378827646544, 4969.950300496948, 4973.0, 5017.347744793299, 4959.355283813081, 4972.950270497394, 4992.525710057539, 5035.29505869186, 5041.7227052511, 4855.927161092516, 4866.562009419169, 4876.024795041077, 4876.195427754381, 4929.260610908249, 4720.929186062281, 4860.0, 4861.5659422448, 4885.0, 4912.435069966999, 4879.609631229564, 4894.95105048945, 4897.7795999180835, 4943.728094954812, 4944.456109827988, 4989.401271847401, 5012.122878496321, 5012.248162775612, 5017.648764586444, 5064.949350506595, 4608.170529304623, 4645.86062418128, 4881.585065269492, 4902.3872015998, 4952.083864485082], "value": 4590.404894602561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1271673414775, 612.9049997250427, 618.9504839612831, 628.8899442597544, 631.7062565906853, 28179.718202817967, 29092.418151636954, 29151.562726559092, 29177.56233656494, 33915.830420847924, 37558.248835023354, 37927.0, 38103.0, 38131.237375252545, 38148.61851381485, 7458.4033277337685, 7659.387249020093, 7687.807804804868, 7733.033370828646, 7740.806479837993, 7342.118945726494, 7561.886571701429, 7672.616369181518, 9602.615895364177, 10078.848817267746, 9625.566849491755, 9674.37116587423, 9684.22526197906, 9692.46691431971, 9784.608615655365, 9554.187894029015, 9666.806663866684, 9675.419474831533, 9675.758106047335, 9683.612655493771, 7258.165310989251, 9601.663941762004, 9863.90136098637, 9926.702198934043, 9974.800503989953, 33503.99488015339, 33989.0, 34057.31885362304, 34312.31375372504, 34427.96716098521, 3173.508106243536, 3342.0, 3458.515807786912, 3519.595246546629, 3625.401808701561, 26802.195934122006, 27129.321766955785, 27237.727622723916, 27722.168334949984, 28833.711662883314, 3526.6297038811067, 3587.928241435183, 3590.317839610492, 3667.5598928128798, 3718.9442158367647, 250657.0, 250959.0, 251115.0, 251189.99999999817, 251646.0, 33040.50439243413, 33922.49116263258, 33969.49045764316, 53768.462315377124, 54759.726201368736, 31814.522782158285, 31916.361672766878, 31917.20206994844, 31945.52081718776, 32092.518612220836, 12156.878431215751, 12340.382980850922, 12413.0, 12414.131010829336, 12426.813597796041, 9799.755006124904, 10338.689839304832, 10390.896091039143, 10465.26743127989, 10475.1096156826, 8014.0, 8199.057108432487, 8267.338612910953, 8272.420930534925, 8354.415190936576, 3129.2802655389387, 3228.741700663941, 3229.1442767666585, 3230.5638738769967, 3235.320582677617, 839.9076101628816, 881.18930583863, 946.3281070440065, 959.8848138223458, 978.1196922769565, 25535.0, 26831.329216769736, 27011.864940675565, 28874.278143046173, 30677.539836902466, 928.6842473559022, 982.9848809939596, 985.6402413119304, 994.6220436234184, 1006.6677996261217, 13901.860981390057, 14110.153390796586, 14468.782968255484, 14582.41670333196, 14776.0, 346039.0, 353910.0, 354891.0, 355149.0, 355269.0, 46334.0, 47936.0, 48018.0, 48084.5191548087, 48190.5180948186, 1156.5836298932377, 1257.698152443407, 1270.307682313123, 1274.0953922714975, 1289.3875409180564, 24747.0, 25531.617025745, 27955.860220698767, 28060.29849253785, 31938.68061319357, 46255.76872115618, 47263.76368118137, 49153.2627010588, 49168.0, 49235.26147107868, 324165.0, 324332.0, 324758.0, 326923.0, 327869.0, 32963.67036329606, 37932.0, 38268.808655957655, 39062.6093739059, 39771.0, 38366.0, 40436.59563404328, 40442.1911561773, 41243.1751364977, 41259.0, 31869.8406507966, 33791.49312760261, 34544.48183277203, 34985.65014349824, 35032.12419689528, 34148.82925585356, 34263.65736342605, 34334.313313734085, 34537.309253815285, 34763.478547822306, 34304.656953430145, 34616.48075278822, 35142.82428587841, 35156.64843351534, 35196.47205291974, 30386.696133038386, 31211.219719507193, 31273.530897037017, 31528.842355788074, 31534.526982094827, 23851.284461466184, 24369.51260974806, 24685.833017002034, 24695.38261543476, 24968.0], "value": 16582.404995916644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.31565497759004, 385.974911630744, 390.46701252789944, 397.3741357362155, 403.77792214282135, 15037.398504059838, 16430.7535386969, 17168.914155429236, 17169.914150429246, 17200.225989830473, 15604.453844115458, 16368.672626547463, 16564.83435165648, 16615.252313645884, 16697.49907502777, 4661.813527458906, 4785.521447855222, 4813.66304358695, 4823.155947709154, 4823.34884790554, 3486.1284678830293, 6421.711023003976, 6805.353491418307, 6817.352351526597, 6829.043933849265, 6099.329073801879, 6449.83875403114, 6794.660266986655, 6817.045613614098, 6830.6926188321395, 6244.1570387997945, 6459.6447195404235, 6496.837579060538, 6518.217813862343, 6936.514443988923, 6692.364225398579, 6701.966490167567, 6734.93265067348, 6737.3262673732725, 6740.696668649874, 20994.37016889496, 22378.216762413238, 23475.530489390287, 23500.529989400115, 23532.64701029486, 2044.6524090904581, 2055.732754741889, 2067.576146889899, 2092.968605470919, 2187.9453013674784, 13774.862251377559, 13988.160710357412, 14532.709345813024, 14588.197649129293, 14725.852741472663, 1918.472420084488, 1977.8714383565023, 1992.8903910284928, 2032.7255820464195, 2056.9177232910665, 81954.0, 85707.5714621423, 87521.56239218827, 88282.11717882803, 88380.55809720975, 15132.924335378253, 16447.91776041136, 16471.423500177436, 16499.505014849572, 16698.081605511572, 29969.700302997127, 29983.400331993238, 30317.968203179946, 30412.54381184284, 30424.239394014883, 8465.703700370457, 8892.822143557092, 8933.553322333857, 8950.731478055668, 9003.684871029482, 7182.8204294892, 7216.242294558996, 7253.891191632129, 7385.704571817175, 7387.445941554405, 6972.895406568906, 8106.513609183467, 8136.75589732309, 8231.34149268057, 8253.83492330162, 2753.6420265365373, 3048.7103725146076, 3145.05648305512, 3258.918527036843, 3364.899053028413, 911.8541033434618, 918.8989211186764, 929.3401684803865, 947.9289053321029, 978.8140253351983, 16031.278592463366, 16713.997160170187, 16926.23831927566, 17153.485395437907, 17297.91351043237, 416.4648426771584, 420.1450049149965, 454.87036194684356, 862.2713806833216, 883.8541640629225, 5135.563477104488, 5511.614187006951, 5602.215689803431, 5637.069883469182, 5664.660120392789, 388666.0, 405788.0, 425541.0, 428368.0, 429540.34136927826, 46862.0, 60355.0, 67531.0, 83230.5838470816, 83381.16618833735, 445.4120560859699, 445.72587858466807, 447.83653966302717, 450.8895320646463, 451.1653441133876, 9339.112784285482, 9466.100720431548, 9682.419054856731, 9730.75673108178, 9748.756281093029, 30423.239419014702, 30787.230319242197, 31748.206294842814, 32532.34935301328, 32725.18187045343, 48929.5107048925, 49628.50371496239, 49681.484178967825, 49742.25386619276, 50207.24689129593, 7705.961470192613, 7833.255840695125, 8014.238647328494, 8029.959850200712, 8132.634031468479, 8541.701040463555, 10105.242106842163, 10938.726531836768, 11724.296542207494, 11734.41327933617, 9862.654807081717, 10108.595656173671, 10203.642872499428, 10403.94798026005, 10661.09380702649, 10065.597376104874, 10101.69694909154, 10128.645497407555, 10244.334118282288, 10259.692209233735, 10254.794904102026, 10591.099756520782, 10592.576296948037, 10671.0, 10685.412302323446, 7012.088428504262, 7833.0, 7978.640961156646, 8024.077231118263, 8199.754007379788, 8361.289290410383, 9156.542172891463, 9258.398204116711, 9497.477638729937, 9778.315517913677], "value": 8658.499301910419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.5135472842953, 1429.5282556756267, 1458.7228426598945, 1595.1306537936823, 1790.0781097734668, 6748.426383757381, 7602.961985190073, 7790.065192176947, 7807.375409967203, 7822.335101516371, 7700.576468294242, 7893.934318866951, 7899.486533375327, 7902.762917112482, 7912.0, 1911.0540282560082, 2164.5021645021575, 2249.089118906845, 2249.5388445368744, 2258.627326491127, 2266.2294819761278, 2273.0, 2286.3598192506124, 2288.8855557222155, 2291.679164916913, 2219.212179676208, 2263.0721404224273, 2263.366257447917, 2267.501149747053, 2269.387265438331, 1895.753552038233, 2176.8040876321206, 2254.6054440472853, 2261.2198791416936, 2262.5022495051226, 2118.120979793384, 2118.311548746648, 2130.3076500137363, 2135.4341099608614, 2165.675148727688, 7644.503107298064, 7659.119201291811, 7707.421943354215, 7717.768466946, 7733.961330193313, 4489.955100448987, 4630.374899388573, 4634.814607415699, 4651.209294419957, 4698.929516057262, 3051.7406020488284, 3062.5099984002454, 3114.2370119320685, 3155.3373791503814, 3159.162821852211, 919.1314208073373, 920.9309301802392, 936.2743873498025, 942.8350038743262, 945.938513996588, 10781.245312828105, 10783.029527342576, 10806.459677016117, 10818.459077046116, 10826.24216304859, 4255.97872010638, 4284.721493103, 4413.492448368479, 4435.068635586563, 4460.620847227957, 8290.958545207235, 8431.95784021076, 8436.325093992466, 8440.11378805229, 8449.915500845036, 4095.3856921461424, 4673.158831410379, 4707.576318131385, 4713.505081966413, 4724.078804633133, 4324.2648749712625, 4385.386045953569, 4406.471223453142, 4410.823567057282, 4427.424434823452, 3356.328734253159, 3383.5263063171174, 3441.587009558869, 3472.1840367513614, 3508.245727168671, 1076.1713480619878, 1087.7878813631266, 1090.536521978156, 1091.6724982505216, 1093.059968427152, 738.0442327186306, 831.6881169561415, 898.7213963671282, 899.0739538275586, 938.1041105743998, 5165.302684137669, 5378.838634840883, 5392.595555333366, 5493.258410114583, 5520.199571062254, 881.4755220643707, 924.2929159193222, 930.0374112793362, 934.3552948465536, 954.7517645412104, 3812.2184952085313, 3924.803759811998, 3925.2542017016676, 3931.056546428894, 4016.216837716617, 9027.909720902839, 9206.953965230132, 9215.53922303882, 9400.90599094014, 9402.15380615748, 9205.217556507638, 9341.626334946663, 9372.62509499626, 9377.43735375866, 9409.482478463613, 7313.122425308997, 7343.706251749977, 7464.626768661546, 7546.698132074765, 7568.810779730441, 5496.340439147328, 5511.641743286674, 5575.721213939368, 5633.464820842013, 5637.154426835843, 8810.86783698258, 8815.426997245158, 8928.642854286016, 9019.143181397756, 9020.548972551214, 9159.908400915905, 9270.953645231732, 9281.582328795086, 9300.860487092563, 9377.202937750095, 5815.738291776965, 6191.7523299069335, 6326.43062124411, 6460.3862633049785, 6574.211094668671, 7456.888146677696, 7508.624568771649, 7539.359154471712, 7541.2458754124145, 7554.886676699964, 6529.118568993125, 6687.164104486939, 6720.260771315249, 6870.20992585839, 6927.965360173167, 6494.603660213077, 6506.837329066811, 6546.901796473152, 6708.597484150967, 6788.59268443895, 6466.127072845105, 6500.284968653539, 6511.34886511345, 6527.379898909596, 6531.281559028598, 4611.146937816515, 4686.109639168547, 4772.809087636456, 4791.856244312677, 4806.206975849085, 4769.689970152068, 4799.064182484522, 4863.781129849094, 4932.556069953578, 4960.677555958851], "value": 4177.076063423407, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5920673521054, 314.08287799625094, 316.1416753514209, 318.2298836814906, 319.10013761193443, 5112.48875112489, 5123.77029512917, 5124.231365295208, 5146.0, 5196.350456192976, 5072.61587054084, 5093.363329583802, 5102.1836506158925, 5103.41310749263, 5116.8976620467565, 3784.924301513968, 3874.496315478984, 3903.8048097595147, 4009.5990400959963, 4032.9395059074136, 3965.940510892339, 3968.9801550992206, 3980.9203815923665, 4011.7994100295014, 4022.35642297231, 3755.906102347436, 3951.960480395188, 3954.268460334847, 3962.1877515109477, 3987.940180897289, 3873.4577159197593, 3966.1472783351574, 3991.1419044905197, 3991.1618560102415, 3994.320965435883, 3505.5793304803333, 3513.437849944022, 3515.7187425005936, 3532.8056956867363, 3549.2546565221332, 4863.416390033183, 4878.0, 4912.533309335608, 4928.605711543104, 4932.260160975847, 4359.738415695068, 4583.197940360424, 4595.448546174481, 4602.539746025404, 4624.884377890546, 5406.432324605899, 5415.377231618375, 5421.674699518002, 5437.238786569884, 5437.537809286216, 3920.2551515212017, 3932.449457075983, 3939.527256729182, 3940.862069827571, 3943.861964831217, 5545.112781954908, 5649.887002259973, 5680.40948534411, 5682.119271512881, 5692.231548740909, 3985.083430810872, 4005.118873847749, 4012.7391719538136, 4014.1770936957855, 4017.417474466186, 4063.329550624114, 4074.4703188585295, 4075.470188875427, 4075.91848163041, 4077.7145599807727, 4533.297338912474, 4537.682362234612, 4612.400387949545, 4617.953820461752, 4630.583247507673, 5395.757190926418, 5398.46015398457, 5409.945900541023, 5411.107167317348, 5415.512603865593, 1404.890136791923, 1424.9572512824632, 1427.1579767936967, 1430.985690143106, 1434.7489189391815, 924.3252425729121, 949.4730424614268, 978.188103873783, 986.837171866634, 1001.3341128149699, 4700.482946875841, 4703.412073490814, 4705.858824235278, 4708.0, 4721.95278047222, 5476.616636835463, 5477.068898287301, 5480.698561579072, 5483.533899618497, 5498.230247765316, 4561.771911404483, 4635.814567417266, 4701.48283688794, 4718.905621887543, 4799.352087468217, 2960.1119664100684, 2972.1677930179585, 2991.1624745071413, 2998.370342228113, 3003.4443627928904, 5262.368515778131, 5270.420253772082, 5280.709560974106, 5284.365876094893, 5314.840554783363, 5522.475364840334, 5718.256626638594, 5722.712389712281, 5730.106296320331, 5744.856378590485, 5257.78968841242, 5269.420363759983, 5275.815346462932, 5282.811367442295, 5286.788528458896, 5444.945550544444, 5543.667379957215, 5594.888102237851, 5600.747966341443, 5609.635373700697, 5484.698341591251, 5500.367457742251, 5502.779888804403, 5511.559075273888, 5538.196961440649, 5270.260813931317, 5270.736463176902, 5286.15421532553, 5289.894202116013, 5304.204369344475, 3769.962300376961, 3888.125171836314, 3890.4747859038666, 3891.416287556889, 3903.341080041028, 5531.419200984, 5563.0, 5601.775928962796, 5608.523275521627, 5613.326400831927, 5425.321834770653, 5428.565714742732, 5442.965836491054, 5444.673319600836, 5463.453654634504, 5298.523132918056, 5426.8100616479815, 5431.565474762088, 5446.237526746179, 5450.645708029124, 5055.898882022266, 5317.468253174651, 5326.6537675050995, 5338.065838478173, 5354.3574771027725, 5173.793048278027, 5342.519173274424, 5348.679079255257, 5351.063563876384, 5351.394581625575, 5274.314339135888, 5278.340207474066, 5286.524212820865, 5287.894242115213, 5292.9735351323], "value": 4076.3396259187375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.4634186556611, 761.1437133225122, 777.1839568453123, 780.5628847845207, 786.5988345943571, 11365.602203922865, 11633.941830290836, 11667.59163429278, 11672.416379181039, 11690.0, 11213.439328033586, 11238.606648767294, 11247.325160490356, 11268.774624507505, 11337.036351910097, 644.2880616918308, 780.9531428114303, 784.5920121536798, 804.4650307545476, 815.0708192660372, 802.7270727952495, 803.1887793328722, 805.8670319397322, 806.3146325623233, 806.770070529899, 849.3672214200429, 852.7910661887846, 853.5220276645099, 853.9146085391442, 854.4958474500044, 667.4893706314649, 826.8842362069315, 848.707196017373, 849.8725191221366, 850.685246458808, 628.0391001767304, 628.2994461175756, 629.361198383641, 629.3832044596276, 629.7166275176144, 11747.765044699143, 11813.173077884465, 11817.290962542274, 11819.940900295529, 11850.822237666442, 11849.94075029628, 12297.815532767016, 12643.241405515606, 12651.810222846665, 13041.217526948414, 11166.162537809616, 11447.313161210353, 11501.42492875353, 11510.0, 11726.003289720384, 3270.9815926529554, 3318.502224666295, 3346.364190803764, 3381.8647254109806, 3450.344434557451, 45077.323840142424, 47396.0, 48784.26823597649, 48824.511754882355, 49103.26345104826, 9929.304948653526, 10081.69754907354, 10147.492625368703, 10152.593896244067, 10186.64346747875, 17524.0, 17556.122193890253, 17581.7362739559, 17582.0, 17598.736018959728, 6969.6515174241085, 7006.264342244093, 7064.823379415453, 7088.291170882871, 7208.207097219301, 3818.713596480275, 3853.9229215416094, 3862.2854771867296, 3866.3620502616754, 3908.1206728485863, 2954.9409011819644, 3049.344390955955, 3049.4053659536175, 3049.9390012199633, 3053.64883038449, 478.44022493682473, 479.1997364401458, 501.29567957020447, 504.8182654244469, 516.3571353664712, 538.1765898175797, 550.9614426621516, 608.4888693497484, 615.7167702856647, 624.709510077816, 8045.15525869787, 8108.472949258279, 8147.75556733299, 8199.508029518249, 8262.082710513203, 511.7620306557394, 521.0802932823569, 593.9316978547522, 614.1555361378105, 618.6500101947902, 3765.246950609889, 3905.882823515299, 3912.56961734209, 3926.9214615707524, 3963.722539422213, 57277.427225728046, 58894.822103557686, 59491.0, 60022.29899654526, 60238.0, 50307.49692503028, 51073.48926510687, 51716.0, 52425.2136217957, 52427.73786131045, 46611.30083048757, 46839.765801170775, 47048.0, 47189.29216061762, 47643.0, 7324.0, 7458.328750412489, 7475.36459400957, 7483.214262502359, 7625.268006035081, 30247.546286805275, 30459.543106852972, 30849.691503085578, 31224.0, 31464.0, 29486.557701634065, 33435.164120896196, 33546.988359199524, 37064.25871482501, 37146.44280335851, 10423.478826058516, 10454.529546170592, 10581.36511809294, 10649.574017039231, 10763.623273185714, 9024.36829421934, 11579.478923448634, 11714.941425292818, 11913.761724765629, 12010.63968080959, 10642.467876606293, 11143.2199746017, 11162.274452160584, 11621.12841536905, 11664.183507154417, 11261.66215013551, 11303.265287756269, 11382.943085284853, 11537.769244615229, 11857.644270671894, 10981.945090274497, 11131.0, 11270.94364528172, 11418.543258269576, 11669.416529173677, 9047.230985366317, 9208.861867072133, 9319.906800931903, 9424.670136545188, 9700.07849254348, 8999.685011024583, 9276.11876871696, 9342.906570934203, 9371.203447706748, 9471.0], "value": 5991.048857148106, "unit": "score"}], "name": "dromaeo_css", "value": 6376.837399935084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 108.0, 111.0, 114.0, 115.0, 104.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 154.0, 180.0, 132.0, 166.0, 162.0, 145.0, 205.0, 131.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 164.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 112.0, 109.0, 75.0, 74.0, 73.0, 111.0, 99.0, 74.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 151.0, 95.0, 101.0, 93.0, 139.0, 95.0, 94.0, 147.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 88.0, 75.0, 62.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 79.0, 80.0, 79.0, 80.0, 82.0, 80.0, 81.0, 82.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 134.0, 132.0, 131.0, 144.0, 132.0, 140.0, 165.0, 131.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 176.0, 177.0, 174.0, 172.0, 174.0, 172.0, 173.0, 171.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 72.0, 77.0, 71.0, 71.0, 72.0, 70.0, 72.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1584.1000000000001, "alertThreshold": 2.0}]} 14:52:07 INFO - Return code: 0 14:52:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:52:07 ERROR - # TBPL SUCCESS # 14:52:07 INFO - Running post-action listener: _resource_record_post_action 14:52:07 INFO - Running post-run listener: _resource_record_post_run 14:52:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 378626048; Read time: 16; Write time: 231164 14:52:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94711808; Read time: 0; Write time: 81444 14:52:08 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283914240; Read time: 16; Write time: 149720 14:52:08 INFO - Running post-run listener: _upload_blobber_files 14:52:08 INFO - Blob upload gear active. 14:52:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:08 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 14:52:08 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'] 14:52:08 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 14:52:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:09 INFO - (blobuploader) - INFO - Done attempting. 14:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:10 INFO - (blobuploader) - INFO - Done attempting. 14:52:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:10 INFO - Return code: 0 14:52:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c30401e85d15a0161b4978d2255cd5ac3986864568251b2176cbffb135a8b8d742c830240142cfbcb6c6152b4f49b0b62cdb9ddeec4104841aad3c9d208e07ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de6c84b77afcc2bfba5ae8f2da22f8862ead94beb21fb415e03ed656748f39dd11095d8fdc2a44a8eac5d7d19ede64b5292c91e6a445b358af0ab3980d3e9cfe"} 14:52:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:10 INFO - Contents: 14:52:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c30401e85d15a0161b4978d2255cd5ac3986864568251b2176cbffb135a8b8d742c830240142cfbcb6c6152b4f49b0b62cdb9ddeec4104841aad3c9d208e07ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de6c84b77afcc2bfba5ae8f2da22f8862ead94beb21fb415e03ed656748f39dd11095d8fdc2a44a8eac5d7d19ede64b5292c91e6a445b358af0ab3980d3e9cfe"} 14:52:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:10 INFO - Copying logs to upload dir... 14:52:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.452770 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-20 14:52:10.396039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:10.399359) ========= 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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 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/c30401e85d15a0161b4978d2255cd5ac3986864568251b2176cbffb135a8b8d742c830240142cfbcb6c6152b4f49b0b62cdb9ddeec4104841aad3c9d208e07ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de6c84b77afcc2bfba5ae8f2da22f8862ead94beb21fb415e03ed656748f39dd11095d8fdc2a44a8eac5d7d19ede64b5292c91e6a445b358af0ab3980d3e9cfe"} build_url:https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/JRV5QJqMSOy0i1_aQIthdw/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/c30401e85d15a0161b4978d2255cd5ac3986864568251b2176cbffb135a8b8d742c830240142cfbcb6c6152b4f49b0b62cdb9ddeec4104841aad3c9d208e07ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de6c84b77afcc2bfba5ae8f2da22f8862ead94beb21fb415e03ed656748f39dd11095d8fdc2a44a8eac5d7d19ede64b5292c91e6a445b358af0ab3980d3e9cfe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:10.424124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:10.424472) ========= 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=cbe409c6de289db6ac707de3000001d4-1461184044.823317-657367411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:10.508733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:10.509085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:10.509375) ========= ========= Total master_lag: 0.18 =========